builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1476393081.59 results: success (0) buildid: 20161013133620 builduid: 8854ff9d10eb47f8aa7f74c7d26688fe revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.595081) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.595541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.595822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.610163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.610459) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 14:11:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-13 14:11:22 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130922 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.755172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.755486) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014967 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.804998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:21.805359) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 14:11:22,535 truncating revision to first 12 chars 2016-10-13 14:11:22,535 Setting DEBUG logging. 2016-10-13 14:11:22,535 attempt 1/10 2016-10-13 14:11:22,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/183b9d08d264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 14:11:22,850 unpacking tar archive at: fx-team-183b9d08d264/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660594 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:22.479493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:22.479811) ========= script_repo_revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:22.480195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:22.480456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:11:22.488645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-13 14:11:22.488974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:23 INFO - MultiFileLogger online at 20161013 14:11:23 in /builds/slave/test 14:11:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:23 INFO - {'append_to_log': False, 14:11:23 INFO - 'base_work_dir': '/builds/slave/test', 14:11:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:23 INFO - 'branch': 'Fx-Team-Non-PGO', 14:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:23 INFO - 'config_files': ('talos/linux_config.py',), 14:11:23 INFO - 'default_actions': ('clobber', 14:11:23 INFO - 'read-buildbot-config', 14:11:23 INFO - 'download-and-extract', 14:11:23 INFO - 'populate-webroot', 14:11:23 INFO - 'create-virtualenv', 14:11:23 INFO - 'install', 14:11:23 INFO - 'run-tests'), 14:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:23 INFO - 'download_minidump_stackwalk': True, 14:11:23 INFO - 'download_symbols': 'ondemand', 14:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:23 INFO - 'installer_path': 'installer.exe', 14:11:23 INFO - 'log_level': 'info', 14:11:23 INFO - 'log_name': 'talos', 14:11:23 INFO - 'log_to_console': True, 14:11:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:23 INFO - 'opt_config_files': (), 14:11:23 INFO - 'pip_index': False, 14:11:23 INFO - 'sps_profile': False, 14:11:23 INFO - 'sps_profile_interval': 0, 14:11:23 INFO - 'suite': 'dromaeojs', 14:11:23 INFO - 'system_bits': '32', 14:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:23 INFO - 'title': 'talos-linux64-ix-065', 14:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:23 INFO - 'use_talos_json': True, 14:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:23 INFO - 'work_dir': 'build'} 14:11:23 INFO - [mozharness: 2016-10-13 21:11:23.310534Z] Running clobber step. 14:11:23 INFO - Running pre-action listener: _resource_record_pre_action 14:11:23 INFO - Running main action method: clobber 14:11:23 INFO - rmtree: /builds/slave/test/build 14:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:24 INFO - Running post-action listener: _resource_record_post_action 14:11:24 INFO - [mozharness: 2016-10-13 21:11:24.322793Z] Finished clobber step (success) 14:11:24 INFO - [mozharness: 2016-10-13 21:11:24.322891Z] Running read-buildbot-config step. 14:11:24 INFO - Running pre-action listener: _resource_record_pre_action 14:11:24 INFO - Running main action method: read_buildbot_config 14:11:24 INFO - Using buildbot properties: 14:11:24 INFO - { 14:11:24 INFO - "project": "", 14:11:24 INFO - "product": "firefox", 14:11:24 INFO - "script_repo_revision": "production", 14:11:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:11:24 INFO - "repository": "", 14:11:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:11:24 INFO - "buildid": "20161013133620", 14:11:24 INFO - "pgo_build": "False", 14:11:24 INFO - "basedir": "/builds/slave/test", 14:11:24 INFO - "buildnumber": 2204, 14:11:24 INFO - "slavename": "talos-linux64-ix-065", 14:11:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:11:24 INFO - "platform": "ubuntu64_hw", 14:11:24 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:11:24 INFO - "branch": "fx-team", 14:11:24 INFO - "repo_path": "integration/fx-team", 14:11:24 INFO - "revision": "183b9d08d2648d4ed50fa1d354b50bd43c11a891", 14:11:24 INFO - "stage_platform": "linux64", 14:11:24 INFO - "builduid": "8854ff9d10eb47f8aa7f74c7d26688fe", 14:11:24 INFO - "slavebuilddir": "test" 14:11:24 INFO - } 14:11:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:11:24 INFO - Running post-action listener: _resource_record_post_action 14:11:24 INFO - [mozharness: 2016-10-13 21:11:24.325296Z] Finished read-buildbot-config step (success) 14:11:24 INFO - [mozharness: 2016-10-13 21:11:24.325383Z] Running download-and-extract step. 14:11:24 INFO - Running pre-action listener: _resource_record_pre_action 14:11:24 INFO - Running main action method: download_and_extract 14:11:24 INFO - mkdir: /builds/slave/test/build/tests 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:24 INFO - trying https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:11:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:11:24 INFO - Downloaded 1361 bytes. 14:11:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:11:24 INFO - Using the following test package requirements: 14:11:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'jsshell-linux-x86_64.zip'], 14:11:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:11:25 INFO - Http code: 200 14:11:25 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 14:11:25 INFO - x-amz-cf-id: 3qsYLk037C5jWnJXcFzxzH6yuW7O8Hgg1iBwISPdyxs_ctTKL49hYQ== 14:11:25 INFO - x-amz-version-id: Jj5spG28GSz3ZV4XNkSlOZrJdMLvSw8T 14:11:25 INFO - Expected file size: 20551732 14:11:25 INFO - Obtained file size: 20551732 14:11:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:11:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:11:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:11:30 INFO - Http code: 200 14:11:30 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:11:30 INFO - x-amz-cf-id: 5oFs1JVGRJti6VE_GEwL0jEiN3an2GJ8bq5oFK73_jVAZxkEu9aUSA== 14:11:30 INFO - x-amz-version-id: Jj5spG28GSz3ZV4XNkSlOZrJdMLvSw8T 14:11:30 INFO - Expected file size: 20551732 14:11:30 INFO - Obtained file size: 20551732 14:11:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:11:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:11:35 INFO - Http code: 200 14:11:35 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:11:35 INFO - x-amz-cf-id: ggL683kZfNj588_z6LvaHAFxkI2Wux5sUrvUUf-w9GtKmUlNvO6KkA== 14:11:35 INFO - x-amz-version-id: BCStAkV4wYC_NHas2U5oJwFzOY1ZkFAr 14:11:36 INFO - Expected file size: 14409006 14:11:36 INFO - Obtained file size: 14409006 14:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:37 INFO - trying https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:11:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:11:38 INFO - Downloaded 55908381 bytes. 14:11:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:11:38 INFO - mkdir: /builds/slave/test/properties 14:11:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:38 INFO - Contents: 14:11:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:11:38 INFO - Running post-action listener: _resource_record_post_action 14:11:38 INFO - Running post-action listener: set_extra_try_arguments 14:11:38 INFO - [mozharness: 2016-10-13 21:11:38.896406Z] Finished download-and-extract step (success) 14:11:38 INFO - [mozharness: 2016-10-13 21:11:38.896703Z] Running populate-webroot step. 14:11:38 INFO - Running pre-action listener: _resource_record_pre_action 14:11:38 INFO - Running main action method: populate_webroot 14:11:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:38 INFO - '--tppagecycles', 14:11:38 INFO - '7'], 14:11:38 INFO - 'tests': ['tsvgm']}}, 14:11:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['damp', 'tps']}, 14:11:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['damp', 'tps']}, 14:11:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['dromaeo_dom']}, 14:11:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['basic_compositor_video']}, 14:11:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore', 14:11:38 INFO - 'tabpaint']}, 14:11:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['tsvgx', 14:11:38 INFO - 'tsvgr_opacity', 14:11:38 INFO - 'tart', 14:11:38 INFO - 'tscrollx', 14:11:38 INFO - 'cart']}, 14:11:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:38 INFO - 'tsvgr_opacity', 14:11:38 INFO - 'tart', 14:11:38 INFO - 'tscrollx', 14:11:38 INFO - 'cart']}, 14:11:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--disable-e10s'], 14:11:38 INFO - 'tests': ['tp5o']}, 14:11:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['tp5o']}, 14:11:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--disable-e10s', 14:11:38 INFO - '--xperf_path', 14:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:38 INFO - 'tests': ['tp5n']}, 14:11:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--xperf_path', 14:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:38 INFO - 'tests': ['tp5n']}}, 14:11:38 INFO - 'talos.zip': {'path': '', 14:11:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:38 INFO - Running post-action listener: _resource_record_post_action 14:11:38 INFO - [mozharness: 2016-10-13 21:11:38.919845Z] Finished populate-webroot step (success) 14:11:38 INFO - [mozharness: 2016-10-13 21:11:38.919936Z] Running create-virtualenv step. 14:11:38 INFO - Running pre-action listener: _resource_record_pre_action 14:11:38 INFO - Running main action method: create_virtualenv 14:11:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:11:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:39 INFO - Using real prefix '/usr' 14:11:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:41 INFO - Installing pip.................done. 14:11:41 INFO - Return code: 0 14:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:11:41 INFO - Reading from file tmpfile_stdout 14:11:41 INFO - Output received: 14:11:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:11:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:11:41 INFO - Using env: {'DISPLAY': ':0', 14:11:41 INFO - 'HOME': '/home/cltbld', 14:11:41 INFO - 'LANG': 'en_US.UTF-8', 14:11:41 INFO - 'LANGUAGE': 'en_US:en', 14:11:41 INFO - 'LOGNAME': 'cltbld', 14:11:41 INFO - 'MAIL': '/var/mail/cltbld', 14:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:41 INFO - 'MOZ_NO_REMOTE': '1', 14:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:41 INFO - 'NO_EM_RESTART': '1', 14:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:41 INFO - 'PWD': '/builds/slave/test', 14:11:41 INFO - 'SHELL': '/bin/bash', 14:11:41 INFO - 'SHLVL': '1', 14:11:41 INFO - 'TERM': 'linux', 14:11:41 INFO - 'TMOUT': '86400', 14:11:41 INFO - 'USER': 'cltbld', 14:11:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:41 INFO - '_': '/tools/buildbot/bin/python'} 14:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:11:41 INFO - Cleaning up... 14:11:41 INFO - Return code: 0 14:11:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:11:41 INFO - Using env: {'DISPLAY': ':0', 14:11:41 INFO - 'HOME': '/home/cltbld', 14:11:41 INFO - 'LANG': 'en_US.UTF-8', 14:11:41 INFO - 'LANGUAGE': 'en_US:en', 14:11:41 INFO - 'LOGNAME': 'cltbld', 14:11:41 INFO - 'MAIL': '/var/mail/cltbld', 14:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:41 INFO - 'MOZ_NO_REMOTE': '1', 14:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:41 INFO - 'NO_EM_RESTART': '1', 14:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:41 INFO - 'PWD': '/builds/slave/test', 14:11:41 INFO - 'SHELL': '/bin/bash', 14:11:41 INFO - 'SHLVL': '1', 14:11:41 INFO - 'TERM': 'linux', 14:11:41 INFO - 'TMOUT': '86400', 14:11:41 INFO - 'USER': 'cltbld', 14:11:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:41 INFO - '_': '/tools/buildbot/bin/python'} 14:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:42 INFO - Downloading/unpacking psutil>=3.1.1 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:44 INFO - Installing collected packages: psutil 14:11:44 INFO - Running setup.py install for psutil 14:11:44 INFO - building 'psutil._psutil_linux' extension 14:11:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:11:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:11:44 INFO - building 'psutil._psutil_posix' extension 14:11:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:11:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:44 INFO - Successfully installed psutil 14:11:44 INFO - Cleaning up... 14:11:44 INFO - Return code: 0 14:11:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:44 INFO - Using env: {'DISPLAY': ':0', 14:11:44 INFO - 'HOME': '/home/cltbld', 14:11:44 INFO - 'LANG': 'en_US.UTF-8', 14:11:44 INFO - 'LANGUAGE': 'en_US:en', 14:11:44 INFO - 'LOGNAME': 'cltbld', 14:11:44 INFO - 'MAIL': '/var/mail/cltbld', 14:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:44 INFO - 'MOZ_NO_REMOTE': '1', 14:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:44 INFO - 'NO_EM_RESTART': '1', 14:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:44 INFO - 'PWD': '/builds/slave/test', 14:11:44 INFO - 'SHELL': '/bin/bash', 14:11:44 INFO - 'SHLVL': '1', 14:11:44 INFO - 'TERM': 'linux', 14:11:44 INFO - 'TMOUT': '86400', 14:11:44 INFO - 'USER': 'cltbld', 14:11:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:44 INFO - '_': '/tools/buildbot/bin/python'} 14:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:46 INFO - Installing collected packages: mozsystemmonitor 14:11:46 INFO - Running setup.py install for mozsystemmonitor 14:11:46 INFO - Successfully installed mozsystemmonitor 14:11:46 INFO - Cleaning up... 14:11:47 INFO - Return code: 0 14:11:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:47 INFO - Using env: {'DISPLAY': ':0', 14:11:47 INFO - 'HOME': '/home/cltbld', 14:11:47 INFO - 'LANG': 'en_US.UTF-8', 14:11:47 INFO - 'LANGUAGE': 'en_US:en', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MAIL': '/var/mail/cltbld', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SHLVL': '1', 14:11:47 INFO - 'TERM': 'linux', 14:11:47 INFO - 'TMOUT': '86400', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - '_': '/tools/buildbot/bin/python'} 14:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:47 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:49 INFO - warning: no files found matching '*.txt' 14:11:49 INFO - no previously-included directories found matching 'build' 14:11:49 INFO - no previously-included directories found matching 'dist' 14:11:49 INFO - no previously-included directories found matching '.git*' 14:11:49 INFO - Installing collected packages: jsonschema, functools32 14:11:49 INFO - Running setup.py install for functools32 14:11:49 INFO - warning: no files found matching '*.txt' 14:11:49 INFO - no previously-included directories found matching 'build' 14:11:49 INFO - no previously-included directories found matching 'dist' 14:11:49 INFO - no previously-included directories found matching '.git*' 14:11:49 INFO - Successfully installed jsonschema functools32 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:11:49 INFO - Using env: {'DISPLAY': ':0', 14:11:49 INFO - 'HOME': '/home/cltbld', 14:11:49 INFO - 'LANG': 'en_US.UTF-8', 14:11:49 INFO - 'LANGUAGE': 'en_US:en', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MAIL': '/var/mail/cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SHLVL': '1', 14:11:49 INFO - 'TERM': 'linux', 14:11:49 INFO - 'TMOUT': '86400', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - '_': '/tools/buildbot/bin/python'} 14:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:49 INFO - Using env: {'DISPLAY': ':0', 14:11:49 INFO - 'HOME': '/home/cltbld', 14:11:49 INFO - 'LANG': 'en_US.UTF-8', 14:11:49 INFO - 'LANGUAGE': 'en_US:en', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MAIL': '/var/mail/cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SHLVL': '1', 14:11:49 INFO - 'TERM': 'linux', 14:11:49 INFO - 'TMOUT': '86400', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - '_': '/tools/buildbot/bin/python'} 14:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - Downloading docopt-0.6.1.tar.gz 14:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:52 INFO - Running setup.py install for blobuploader 14:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:52 INFO - Running setup.py install for requests 14:11:53 INFO - Running setup.py install for docopt 14:11:53 INFO - Successfully installed blobuploader requests docopt 14:11:53 INFO - Cleaning up... 14:11:53 INFO - Return code: 0 14:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:53 INFO - Using env: {'DISPLAY': ':0', 14:11:53 INFO - 'HOME': '/home/cltbld', 14:11:53 INFO - 'LANG': 'en_US.UTF-8', 14:11:53 INFO - 'LANGUAGE': 'en_US:en', 14:11:53 INFO - 'LOGNAME': 'cltbld', 14:11:53 INFO - 'MAIL': '/var/mail/cltbld', 14:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:53 INFO - 'MOZ_NO_REMOTE': '1', 14:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:53 INFO - 'NO_EM_RESTART': '1', 14:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:53 INFO - 'PWD': '/builds/slave/test', 14:11:53 INFO - 'SHELL': '/bin/bash', 14:11:53 INFO - 'SHLVL': '1', 14:11:53 INFO - 'TERM': 'linux', 14:11:53 INFO - 'TMOUT': '86400', 14:11:53 INFO - 'USER': 'cltbld', 14:11:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:53 INFO - '_': '/tools/buildbot/bin/python'} 14:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:53 INFO - Running setup.py (path:/tmp/pip-s36oMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:53 INFO - Running setup.py (path:/tmp/pip-fX5S2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:53 INFO - Running setup.py (path:/tmp/pip-geggGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:53 INFO - Running setup.py (path:/tmp/pip-PR4YNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:53 INFO - Running setup.py (path:/tmp/pip-k0OOVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:53 INFO - Running setup.py (path:/tmp/pip-EzAzdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:54 INFO - Running setup.py (path:/tmp/pip-1Jp9O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:54 INFO - Running setup.py (path:/tmp/pip-OIAQIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:54 INFO - Running setup.py (path:/tmp/pip-xK5IVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:54 INFO - Running setup.py (path:/tmp/pip-0hoECe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:54 INFO - Running setup.py (path:/tmp/pip-EydBtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:54 INFO - Running setup.py (path:/tmp/pip-myTqhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:54 INFO - Running setup.py (path:/tmp/pip-lyAntt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:54 INFO - Running setup.py (path:/tmp/pip-6oh8GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:54 INFO - Running setup.py (path:/tmp/pip-HzSqX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:54 INFO - Running setup.py (path:/tmp/pip-y2_it0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:54 INFO - Running setup.py (path:/tmp/pip-MNGIE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:54 INFO - Running setup.py install for manifestparser 14:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Running setup.py install for mozcrash 14:11:55 INFO - Running setup.py install for mozdebug 14:11:55 INFO - Running setup.py install for mozdevice 14:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozfile 14:11:55 INFO - Running setup.py install for mozhttpd 14:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozinfo 14:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozInstall 14:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for mozleak 14:11:55 INFO - Running setup.py install for mozlog 14:11:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:55 INFO - Running setup.py install for moznetwork 14:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozprocess 14:11:56 INFO - Running setup.py install for mozprofile 14:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozrunner 14:11:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Running setup.py install for mozscreenshot 14:11:56 INFO - Running setup.py install for moztest 14:11:56 INFO - Running setup.py install for mozversion 14:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:56 INFO - Cleaning up... 14:11:56 INFO - Return code: 0 14:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:56 INFO - Using env: {'DISPLAY': ':0', 14:11:56 INFO - 'HOME': '/home/cltbld', 14:11:56 INFO - 'LANG': 'en_US.UTF-8', 14:11:56 INFO - 'LANGUAGE': 'en_US:en', 14:11:56 INFO - 'LOGNAME': 'cltbld', 14:11:56 INFO - 'MAIL': '/var/mail/cltbld', 14:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:56 INFO - 'MOZ_NO_REMOTE': '1', 14:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:56 INFO - 'NO_EM_RESTART': '1', 14:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:56 INFO - 'PWD': '/builds/slave/test', 14:11:56 INFO - 'SHELL': '/bin/bash', 14:11:56 INFO - 'SHLVL': '1', 14:11:56 INFO - 'TERM': 'linux', 14:11:56 INFO - 'TMOUT': '86400', 14:11:56 INFO - 'USER': 'cltbld', 14:11:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:56 INFO - '_': '/tools/buildbot/bin/python'} 14:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:56 INFO - Running setup.py (path:/tmp/pip-Plyaxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:56 INFO - Running setup.py (path:/tmp/pip-8kSl0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:57 INFO - Running setup.py (path:/tmp/pip-ip5myE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:57 INFO - Running setup.py (path:/tmp/pip-qJImuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:57 INFO - Running setup.py (path:/tmp/pip-JkJ40t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:57 INFO - Running setup.py (path:/tmp/pip-OrB6AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:57 INFO - Running setup.py (path:/tmp/pip-HbN8xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:57 INFO - Running setup.py (path:/tmp/pip-TNUnhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:57 INFO - Running setup.py (path:/tmp/pip-KgOoxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:57 INFO - Running setup.py (path:/tmp/pip-7iFpfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:57 INFO - Running setup.py (path:/tmp/pip-9Wp2Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:57 INFO - Running setup.py (path:/tmp/pip-buiD_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:57 INFO - Running setup.py (path:/tmp/pip-loW3jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:57 INFO - Running setup.py (path:/tmp/pip-TCcY5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:57 INFO - Running setup.py (path:/tmp/pip-VLOWu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:57 INFO - Running setup.py (path:/tmp/pip-liVk8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:58 INFO - Running setup.py (path:/tmp/pip-XpAwQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:00 INFO - Downloading blessings-1.6.tar.gz 14:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:00 INFO - Installing collected packages: blessings 14:12:00 INFO - Running setup.py install for blessings 14:12:00 INFO - Successfully installed blessings 14:12:00 INFO - Cleaning up... 14:12:00 INFO - Return code: 0 14:12:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:00 INFO - Reading from file tmpfile_stdout 14:12:00 INFO - Current package versions: 14:12:00 INFO - argparse == 1.2.1 14:12:00 INFO - blessings == 1.6 14:12:00 INFO - blobuploader == 1.2.4 14:12:00 INFO - docopt == 0.6.1 14:12:00 INFO - functools32 == 3.2.3-2 14:12:00 INFO - jsonschema == 2.5.1 14:12:00 INFO - manifestparser == 1.1 14:12:00 INFO - mozInstall == 1.12 14:12:00 INFO - mozcrash == 0.17 14:12:00 INFO - mozdebug == 0.1 14:12:00 INFO - mozdevice == 0.48 14:12:00 INFO - mozfile == 1.2 14:12:00 INFO - mozhttpd == 0.7 14:12:00 INFO - mozinfo == 0.9 14:12:00 INFO - mozleak == 0.1 14:12:00 INFO - mozlog == 3.4 14:12:00 INFO - moznetwork == 0.27 14:12:00 INFO - mozprocess == 0.23 14:12:00 INFO - mozprofile == 0.28 14:12:00 INFO - mozrunner == 6.12 14:12:00 INFO - mozscreenshot == 0.1 14:12:00 INFO - mozsystemmonitor == 0.3 14:12:00 INFO - moztest == 0.7 14:12:00 INFO - mozversion == 1.4 14:12:00 INFO - psutil == 3.1.1 14:12:00 INFO - requests == 1.2.3 14:12:00 INFO - wsgiref == 0.1.2 14:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:00 INFO - Using env: {'DISPLAY': ':0', 14:12:00 INFO - 'HOME': '/home/cltbld', 14:12:00 INFO - 'LANG': 'en_US.UTF-8', 14:12:00 INFO - 'LANGUAGE': 'en_US:en', 14:12:00 INFO - 'LOGNAME': 'cltbld', 14:12:00 INFO - 'MAIL': '/var/mail/cltbld', 14:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:00 INFO - 'MOZ_NO_REMOTE': '1', 14:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:00 INFO - 'NO_EM_RESTART': '1', 14:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:00 INFO - 'PWD': '/builds/slave/test', 14:12:00 INFO - 'SHELL': '/bin/bash', 14:12:00 INFO - 'SHLVL': '1', 14:12:00 INFO - 'TERM': 'linux', 14:12:00 INFO - 'TMOUT': '86400', 14:12:00 INFO - 'USER': 'cltbld', 14:12:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:00 INFO - '_': '/tools/buildbot/bin/python'} 14:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:12:00 INFO - Cleaning up... 14:12:00 INFO - Return code: 0 14:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe015d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2691ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:12:00 INFO - Using env: {'DISPLAY': ':0', 14:12:00 INFO - 'HOME': '/home/cltbld', 14:12:00 INFO - 'LANG': 'en_US.UTF-8', 14:12:00 INFO - 'LANGUAGE': 'en_US:en', 14:12:00 INFO - 'LOGNAME': 'cltbld', 14:12:00 INFO - 'MAIL': '/var/mail/cltbld', 14:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:00 INFO - 'MOZ_NO_REMOTE': '1', 14:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:00 INFO - 'NO_EM_RESTART': '1', 14:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:00 INFO - 'PWD': '/builds/slave/test', 14:12:00 INFO - 'SHELL': '/bin/bash', 14:12:00 INFO - 'SHLVL': '1', 14:12:00 INFO - 'TERM': 'linux', 14:12:00 INFO - 'TMOUT': '86400', 14:12:00 INFO - 'USER': 'cltbld', 14:12:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:00 INFO - '_': '/tools/buildbot/bin/python'} 14:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:12:00 INFO - Cleaning up... 14:12:00 INFO - Return code: 0 14:12:00 INFO - Running post-action listener: _resource_record_post_action 14:12:00 INFO - Running post-action listener: _start_resource_monitoring 14:12:01 INFO - Starting resource monitoring. 14:12:01 INFO - [mozharness: 2016-10-13 21:12:01.008375Z] Finished create-virtualenv step (success) 14:12:01 INFO - [mozharness: 2016-10-13 21:12:01.008876Z] Running install step. 14:12:01 INFO - Running pre-action listener: _resource_record_pre_action 14:12:01 INFO - Running main action method: install 14:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:01 INFO - Reading from file tmpfile_stdout 14:12:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:01 INFO - Reading from file tmpfile_stdout 14:12:01 INFO - Output received: 14:12:01 INFO - Usage: mozinstall [options] installer 14:12:01 INFO - Options: 14:12:01 INFO - -h, --help show this help message and exit 14:12:01 INFO - -d DEST, --destination=DEST 14:12:01 INFO - Directory to install application into. [default: 14:12:01 INFO - "/builds/slave/test"] 14:12:01 INFO - --app=APP Application being installed. [default: firefox] 14:12:01 INFO - mkdir: /builds/slave/test/build/application 14:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:12:17 INFO - Reading from file tmpfile_stdout 14:12:17 INFO - Output received: 14:12:17 INFO - /builds/slave/test/build/application/firefox/firefox 14:12:17 INFO - Running post-action listener: _resource_record_post_action 14:12:17 INFO - [mozharness: 2016-10-13 21:12:17.476369Z] Finished install step (success) 14:12:17 INFO - [mozharness: 2016-10-13 21:12:17.476615Z] Running run-tests step. 14:12:17 INFO - Running pre-action listener: _resource_record_pre_action 14:12:17 INFO - Running main action method: run_tests 14:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:17 INFO - Python 2.7.3 14:12:17 INFO - Return code: 0 14:12:17 INFO - grabbing minidump binary from tooltool 14:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ef60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26901d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:12:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:12:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:12:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:17 INFO - Return code: 0 14:12:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:12:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:12:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:12:17 INFO - Using env: {'DISPLAY': ':0', 14:12:17 INFO - 'HOME': '/home/cltbld', 14:12:17 INFO - 'LANG': 'en_US.UTF-8', 14:12:17 INFO - 'LANGUAGE': 'en_US:en', 14:12:17 INFO - 'LOGNAME': 'cltbld', 14:12:17 INFO - 'MAIL': '/var/mail/cltbld', 14:12:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:17 INFO - 'MOZ_NO_REMOTE': '1', 14:12:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:17 INFO - 'NO_EM_RESTART': '1', 14:12:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:17 INFO - 'PWD': '/builds/slave/test', 14:12:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:17 INFO - 'SHELL': '/bin/bash', 14:12:17 INFO - 'SHLVL': '1', 14:12:17 INFO - 'TERM': 'linux', 14:12:17 INFO - 'TMOUT': '86400', 14:12:17 INFO - 'USER': 'cltbld', 14:12:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085', 14:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:17 INFO - '_': '/tools/buildbot/bin/python'} 14:12:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:12:17 INFO - mozversion application_buildid: 20161013133620 14:12:17 INFO - mozversion application_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 14:12:17 INFO - mozversion application_display_name: Nightly 14:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:17 INFO - mozversion application_name: Firefox 14:12:17 INFO - mozversion application_remotingname: firefox 14:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:17 INFO - mozversion application_vendor: Mozilla 14:12:17 INFO - mozversion application_version: 52.0a1 14:12:17 INFO - mozversion platform_buildid: 20161013133620 14:12:17 INFO - mozversion platform_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 14:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:17 INFO - mozversion platform_version: 52.0a1 14:12:17 INFO - using testdate: 1476393137 14:12:17 INFO - actual date: 1476393137 14:12:17 INFO - starting webserver on 'localhost:60232' 14:12:17 INFO - SUITE-START | Running 2 tests 14:12:17 INFO - TEST-START | dromaeo_css 14:12:17 INFO - operating with platform_type : linux_ 14:12:17 INFO - Initialising browser for dromaeo_css test... 14:12:17 INFO - TEST-INFO | started process 5291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4i9CiA/profile http://localhost:60232/getInfo.html) 14:12:21 INFO - PROCESS | 5291 | __metrics Screen width/height:1600/1200 14:12:21 INFO - PROCESS | 5291 | colorDepth:24 14:12:21 INFO - PROCESS | 5291 | Browser inner width/height: 1024/697 14:12:21 INFO - PROCESS | 5291 | __metrics 14:12:22 INFO - PROCESS | 5291 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:12:22 INFO - PROCESS | 5291 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:23 INFO - PROCESS | 5291 | console.error: PushService: 14:12:23 INFO - PROCESS | 5291 | stateChangeProcessEnqueue: Error transitioning state 14:12:23 INFO - PROCESS | 5291 | UnknownError 14:12:23 INFO - TEST-INFO | 5291: exit 0 14:12:23 INFO - Browser initialized. 14:12:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:23 INFO - TEST-INFO | started process 5372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4i9CiA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:36 INFO - PROCESS | 5372 | RSS: Main: 174989312 14:12:36 INFO - PROCESS | 5372 | 14:13:26 INFO - PROCESS | 5372 | 1476393206722 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:15:41 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60232/tests/dromaeo/cssquery-ext.html) 14:15:43 INFO - PROCESS | 5372 | RSS: Main: 328916992 14:15:43 INFO - PROCESS | 5372 | 14:18:45 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-ext.html (next: http://localhost:60232/tests/dromaeo/cssquery-jquery.html) 14:18:46 INFO - PROCESS | 5372 | RSS: Main: 275755008 14:18:46 INFO - PROCESS | 5372 | 14:21:48 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60232/tests/dromaeo/cssquery-mootools.html) 14:21:49 INFO - PROCESS | 5372 | RSS: Main: 246394880 14:21:49 INFO - PROCESS | 5372 | 14:24:51 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60232/tests/dromaeo/cssquery-prototype.html) 14:24:52 INFO - PROCESS | 5372 | RSS: Main: 218828800 14:24:52 INFO - PROCESS | 5372 | 14:27:55 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60232/tests/dromaeo/cssquery-yui.html) 14:27:55 INFO - PROCESS | 5372 | RSS: Main: 218599424 14:27:55 INFO - PROCESS | 5372 | 14:30:58 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:60232/tests/dromaeo/cssquery-yui.html (next: http://localhost:60232/tests/dromaeo/cssquery-dojo.html) 14:30:58 INFO - PROCESS | 5372 | RSS: Main: 312889344 14:30:58 INFO - PROCESS | 5372 | 14:30:58 INFO - PROCESS | 5372 | __start_tp_report 14:30:58 INFO - PROCESS | 5372 | _x_x_mozilla_page_load 14:30:58 INFO - PROCESS | 5372 | _x_x_mozilla_page_load_details 14:30:58 INFO - PROCESS | 5372 | |i|pagename|runs| 14:30:58 INFO - PROCESS | 5372 | |0;dojo.html;2505.13572817378;2579.974200257997;2613.7255588163243;2615.50305441966;2636.6704161979765;4526.343680166374;4628.606568441686;4685.508021657728;4704.435467743871;4709.670323077382;4644.930326045112;4782.210935195697;4840.757962101899;4877.170880950238;4901.362822833035;4346.6739994500385;4403.185410699031;4454.242778727608;4454.287314029756;4480.551944805509;4431.689781715281;4518.471960332417;4550.476695180047;4562.954370456303;4597.954020459802;4215.725977811432;4488.910221795579;4494.235979883428;4535.750533720644;4607.331936869152;4303.117860838521;4380.058287468178;4422.29243321067;4453.465584129893;4483.282674772054;4436.9556304436865;4444.666650001231;4455.487618923833;4493.348464472633;4509.549045095497;4766.594839438617;4810.831620893252;4839.104765618336;4840.128776820171;4892.584130348924;4876.097921884463;4939.431965323962;4946.3817022872145;5071.416787069497;5153.613478989091;5143.819966301162;5170.172772356443;5170.224466330081;5215.322008138917;5231.424543300234;4786.5452781985305;4793.209120495079;4796.904061918742;4799.328094066834;4859.659823812299;4989.90020199594;5043.167877300278;5257.842264732064;5261.579073674096;5264.289320941701;4895.143349913751;4918.311436398907;4936.234883593049;4937.1113199624415;5022.422421421583;5017.9247311290355;5038.244263360452;5045.293658887758;5050.49495050492;5104.642675012788;4976.154053810861;4997.075541024922;5019.372578427697;5019.67372120811;5035.899282014339;4858.368412106403;4908.435529914034;4915.65590408668;4973.278874563168;4975.527324904128;4184.476940382452;4194.098268872207;4194.412782210493;4199.076203235283;4225.408442817947;3709.795961222159;3709.8145092745794;3742.0270729610497;3743.981280093582;3775.622437756257;4431.778411079497;4438.622717069021;4440.067585806952;4442.355858400514;4495.842645507457;4903.289023091632;4905.484924082992;4958.7024778513405;5079.644424890223;5141.53726164647;4444.3333499974615;4515.796789144496;4518.728876267434;4535.387722657465;4600.332951721982;4609.285560738091;4632.444106707149;4634.629229661619;4636.536346365404;4645.814167433265;4698.318743782064;4934.7285899275885;4935.457099719028;4936.481669424658;5001.349824522861;4980.800767969386;5000.524950129732;5051.06555287273;5103.617228707936;5146.665466744649;4894.779734911866;4905.950940490692;4912.140375434356;4950.059488697136;4971.428285747185;5100.770465328995;5108.61685373591;5110.642255042111;5113.079645663667;5178.249153872743;4832.009438065118;4860.95139048605;4879.121758083579;5152.76812543444;5179.171332586768;5039.3448851649055;5041.747912604428;5077.492250774893;5092.745362731775;5101.464346243591;5041.2438134280155;5041.924371134362;5043.142665746758;5044.495550444926;5060.949390506048;4649.883752906205;4652.953470465252;4952.1581331173065;4961.900761984813;4964.478729733326;4843.07981483517;4976.776045078052;5018.824341148043;5019.222020586815;5098.082345177755;4741.5021422750115;4793.18515852299;4907.77914993819;4923.975380123076;4990.775415106402 14:30:58 INFO - PROCESS | 5372 | |1;ext.html;543.5868739757784;556.8607848037988;564.272089005183;566.365670449097;576.0753989846294;27441.862790686042;37441.25117497648;38233.99999999996;38279.61720382802;41795.79102104485;39097;39502.40746388799;39518.20963580727;39596;39625.20749585007;7694.153643099268;7818.14000459949;7837.216278372174;7843.372530197599;7845.411594130434;7623.923760762377;7694.5383277003275;7705.229477052306;7708.653110610036;7719.49823261489;7697.422693297997;7743.341815945651;7747.070351557821;7753.185915478878;7762.9611851940945;7702.42231832612;7718.807029824243;7733.45865789395;7745.7288994885475;7750.534967901887;7623.313901748814;7692.192319806451;7698.384129269701;7699.345555627779;7699.884501732478;37141.442878356844;37494.06264843373;37499;37502.81248593739;37518.43722344167;3002.459557279689;3124.9218769530717;3215.951760723591;3330.6502817204087;3379.7465190110593;27857.721422785715;28108.85945570259;28324.71675283262;28449.715502844912;28555.143345699664;3248.496483045108;3285.375778602082;3356.8825091121694;3361.126107212118;3448.327576122657;229788;230256.9999999983;230537;230656;232348;52028.47971520312;52365.21452178144;52427.21359179616;52450;52531.47468525342;54549.1817622736;54551;54615.45384546104;54648.726756366756;54651.453485465434;14568.63578410527;14686.706265874836;14704;14774.48289309869;14776.926115369355;11349.162709322669;11368.147388945863;11380.430978451044;11385.715357115972;11388.316700997966;15359.385624574892;16029;16050.357985680675;16066.43767468133;16151.757723634155;5904.498117660047;5941.197938278277;5976.581639285208;6009.1587177795145;6288.591241569284;671.2012704881175;698.72400401842;713.4328209073695;876.3164731509432;903.1010456434917;27523.724762752117;27908.720912791017;28318;28423.85788071088;28435.146945591667;902.9232515236279;920.8204400141908;935.9906400935904;953.413650604873;996.8903420623726;14388.208648524222;14605.78091328631;14903;14998.325075371635;15083.321250543751;352914;357436;357660.63509047386;357688;358286;47943.28085078727;47980.760096199294;48062.51937480651;48079;48131;1059.6450189186555;1081.405227125078;1139.2651739627893;1150.3730466895563;1157.7568710570706;27106.864465677547;27111.457770844867;28404.147875563765;29097.85451072731;29509.409811804075;43490.34764478472;46732.53267467282;46767.532324676315;46842;46859.76570117127;263149;265064;266046;267376;267647;24262.30163888511;24589;25083;25100;26264;41059.58940410558;41124.588754112076;41170.176596468504;42215.5778442224;42790;35764.821175895;35830.28339433249;35988.64011359853;36040.098997525274;36650.45024324691;34971.82514087515;34974.300513990085;35411.82294088513;35506;35868.820655896554;34293.82853085719;34759.652403475644;35073.29853402969;35529.644703552636;35882.64117358793;30093.849530752206;32192;32362.676373235965;32479.512807307437;32592.837035814668;24474.26577202687;24704.13535526248;24721.752782471944;25021.74978250194;25083.24750257495 14:30:58 INFO - PROCESS | 5372 | |2;jquery.html;342.75493022488916;369.1969965325417;373.74585282008235;377.5205489028933;393.49435974772405;12212.877871221284;12298.877011229884;13169.407376668061;13169.736605267914;16801.243944022517;16172.19139043046;16530.504084877444;16532.917335413305;16652.16739163043;16666;4870.4885986971385;4894.241392584137;5124.948750512484;5158.380994280692;5159.22611608258;3562.073860796199;3768.6796622287;5062.139436295838;5149.150390185615;5153.56194723449;3745.793981331026;3746.662800347968;3757.7933213673236;3788.602196769341;3882.646875475506;5841.707914604252;5996.040633498619;6000.519958403339;6002.099685047234;6009.729562169713;5073.847784566469;5262.736863156827;5321.760520776575;5328.786848526054;5334.4398838122215;19395.709064364044;19432.611347773105;19471.707924381146;19615.607687846306;19616.80383196164;1880.6332765110808;1909.255390397746;1986.5728868293243;2154.396768904709;2229.6321107017325;12486.375681215903;12541.811872821914;12709.17390369623;12725.490980360775;13407.798883016763;1657.5856035991003;1676.8490835824712;1680.882338236324;1690.4194578069544;1723.7672914156553;68188.6590567049;69332.65333673349;69337.65331173362;69469.30530694679;69762;9152.17630413266;9233.938097118917;9315.254779617615;9463.066449400707;9757.268204884662;13038.217706937614;13067.477300907858;13088.345582720825;13110.213387196798;13118.803217951738;6936.410405115521;7194.532355396883;7210.927890721131;7328.450366222448;7374.115106187184;7069.717211311593;7157.355837974607;7161.9641901790155;7167.89248161278;7460.813479663052;5766.135079738073;5889.114333976407;5906.497947674496;6006.489448396847;6130.2030736004035;1679.4038116468478;1712.7259638458036;1720.3656526300065;1721.672882152387;1777.9111044447725;824.085265355455;837.1042984007054;852.4373913217247;906.3157316226207;922.5341202692731;16262.51212463628;16421.261043253082;16564.171791410383;16738.414155504743;17198.484045478657;843.1736897840028;845.8350621628723;852.5268475995758;906.0486489186328;933.4819175357605;9408.811823763486;9456.148946594702;9676.516174191262;9886.950565247127;9986.800263994824;306817;306968;370140;373467;404409;58178;66534.33465665378;67817.66091169513;68391;81151;423.2656341247932;441.1441802902359;442.80073966715105;445.23864192231;446.00985811497776;9440.527973601154;9480.288978326515;9844.3601165924;10065.547050382896;10354.256122127492;24542.386440339134;25945.610815838154;32267.677323226468;33403.331933360714;34041;46895.29657055215;46990.30679324336;50513;51227;52421.21368179557;7274.4907856449545;7334.853302933805;7584.772456826304;7841.098273698598;8047.597620118853;6803.591784492946;9974.551145198338;10155.492225388849;10850.891491085304;11663.300201987908;9624.951875240578;9885.901140988499;9978.550965206729;10149.84775228387;10312.175025998053;9737.805243895224;10003.699889003341;10135;10280.434576098387;10305.124064454305;9987.750306242402;10457.424841633783;10497.47512624381;10571;10987;7246.239144889711;7646.311831935152;7774.416918731004;7808.180141085331;8061.516309021477;9589.904100958902;9673.758156045873;9737.9026209737;9906.702798916043;10196.898031019891 14:30:58 INFO - PROCESS | 5372 | |3;mootools.html;1317.4400879626157;1367.2275164532039;1422.5803388000538;1629.291258302639;1678.1693061934345;7410.4812663113535;8024.879626805603;8027.678892844294;8040.2361775631225;8041.1154772975;6497.285298617148;6758.628275444848;7529.548227106377;7790.8441831163345;7795.298423141916;2177.77133400993;2210.8673479591275;2210.9447263818374;2211.0602993727603;2212;2144.764075951644;2172.73927128744;2211.8119959803435;2212.7676593957644;2219.3341997400794;1801.2524802207133;1886.3397810766191;2073.8651987620833;2163.026638012893;2166.696662467248;2182.68351089092;2183.4213933307688;2200.3618950504415;2201.570693714726;2202.493426511895;2178.923737669174;2179.5422961178174;2183.912643494258;2184.2791878680155;2196.4728465168405;7815.374770018385;7983.441159118864;7993.400494962901;7993.960030199812;8002.399820013464;4588.105319462706;4754.976225118887;4767.046590681843;4774;4788.209945359012;2816.3100040490212;2849.957250641242;2856.1146044725992;3000.2799328161304;3066.034199227259;859.6561375449808;895.901450840407;909.9499527525984;917.2753524715466;919.7654598077514;10941.398223097727;10954.178436617285;10978.560857565688;10981.12151027916;10999.670009899715;3991.9201615967518;4307.5477074906685;4329.134173165379;4404.66964977628;4440.822367105279;9297.349185557081;9313.068693130634;9317.906820931705;9323.067693230623;9325.114114159143;4778.068276686083;4803.063402636522;4804.279358096243;4811.663183577186;4813.518648135158;4095.3856921461424;4370.519242883281;4382.430284063052;4383.320585309282;4388.451443569554;3357.932841343208;3365.495175723612;3468.583769947572;3473.4095203815414;3512.666296701809;1050.6112738286884;1054.8734151901667;1059.86751656043;1062.7608788022787;1070.282910449985;660.9306022867626;709.2446544430165;791.8495485857669;819.2831272636444;822.5106061893164;5328.573714102862;5417.674939503642;5427.185922111636;5503.394626591072;5649.519790817826;802.5465611929242;851.7827953871723;864.7492227254025;877.4647465046316;925.6898938855425;3704.944425833615;3709.7774133552075;3752.6434988676033;3757.774533527997;3891.8832435026993;9430.90569094314;9622.855657165148;9811.31320807551;9967.40195588267;9978.351407158512;9867.950660246797;9884.456354900549;9897.158741507052;9899.059589339002;9899.109080182818;7297.306755858185;7380.077490313711;7398.482106252511;7415.703371865173;7444.8883266751045;5352.4915133062295;5364.356277246756;5409.134538473825;5417.972910135424;5556;8847.292216622784;8931.464112153291;8946.463212207289;8979.551022448983;9056.864147037668;8234.176582341717;8581.184787445183;8591.785205369915;8831.823363532822;9100.863487047567;6581.111549940697;6700.061991321317;6719.832004199934;6719.865602687821;6762.053312536151;7375.704971801068;7452.06849143857;7453;7457.664405101892;7459.738909138154;6642.236142843635;6799.830004249933;6828.829279268058;6870.3473170048765;6985;6673.632950187786;6679.23188833271;6722.2605513394465;6775.356341147583;6799.694013769491;6233.844153896189;6298.464630506458;6337.746490140343;6355.396237357444;6359.872802544016;4501.122281155274;4688.140234457047;4772.164871147605;4782.2826576012485;4864.343313652612;4531.139083574242;4564.360989461412;4626;4693.319468677091;4734.26618874075 14:30:59 INFO - PROCESS | 5372 | |4;prototype.html;290.8342244920396;296.0983804315858;303.6759727587717;308.55722038874217;308.58341239326927;4704.670673052883;4733.455652599952;4737.715737055775;4738;4746.644001699873;4651.7441540715245;4656.789234798951;4680.719156850591;4681.391419115519;4682.133805246031;3744.9812750936208;3749.568799588041;3751.493548370976;3751.6998640108727;3757.210985693001;3521.559805024372;3765.8870233893026;3772.4152756322815;3772.717046221531;3778.848846046155;3697.5193224880863;3749.9812500937455;3757.8684746033896;3764.3224219640456;3770.2271034437877;3738.308412943587;3739.7943113128767;3745.6628903398687;3747.906302342436;3748.6063963283736;3156.794808337451;3212.6947939945903;3248.5127230915314;3345.3476572068457;3351.4470112431663;4568.840090596813;4569.543045695404;4572.862814115582;4574.4510658721165;4603.434832157082;4180.352045432963;4232.513260974996;4233.407322974786;4233.767142807144;4249.936250956238;4593.44878614565;4615.423072115986;4860.1737704590305;4871.512848715136;4882.658213925027;3574.410222313315;3576;3585.4621806728937;3591.407417776064;3593.5148754918014;5089.567386772129;5127.794888204505;5136.332276804029;5139.948600513984;5140.7637677610355;3606.7376418253402;3701.4632878232505;3714.4428335749312;3715.5169827922196;3722.2927643747603;3746.3069332173636;3763.435484677266;3767.3595488766973;3778.508793856781;3782;4218.240716671029;4228.3234682451275;4230.682698797603;4230.957690423118;4239.258129827268;4910.361652985161;4915.508449155056;4918.9508104919205;4921.188003979375;4933.161362568372;1249.900007999358;1294.6664935116657;1297.2411139483509;1305.1386085183733;1316.795896636023;836.85773418519;847.7541512961295;862.978425539354;863.2619110660421;865.1391865094146;3971.3645816669195;3986.242613903349;3992.7223288547966;3993.4009898514873;4011.799410029487;4441.467023957081;4451.933221001687;4463;4477.686561940698;4502.774861256924;3947.3289540778137;3955.980220098881;3966.643002129822;3983.1876496194163;3988.700847436454;2295.4031951692346;2324.651302304634;2329.8895973875065;2359.64605309205;2390.8206884483734;4256.5953235432235;4615.676902616851;4659.370984917061;4720.442254056154;4849.569377033784;5194.168932970707;5198.582659063553;5205.29728486657;5213.6089793265655;5218.373795144607;4774.466894498047;4795;4813.663043586916;4822.180229360947;4852.611791056707;4938.851834444972;4946.078985802945;5039.622028347815;5062.392512898328;5072.28987941681;4941.925871111865;5018.272350509083;5027.497250274943;5034.597232221487;5041.218611115283;4846.539578740014;4856.490068542894;4856.8785780354365;4857.975710121426;4860.343853579721;3609.9278014440088;3696.5009723688036;3713.220223752934;3736.981315093407;3763.5671897731017;5072.82245121419;5081.568066714222;5084.161113416245;5102.08162530748;5127;4886.951130488792;4941.950580494149;4946.1838796599595;4951.5048495150195;4953.356063711694;4678.502879078798;4905.313256144214;4916.3362946001835;4933.358663373739;4938.30863679078;4834.516548345137;4851.2723091535145;4851.975740121276;4853.611711063177;4862.3922009748785;4945.826896058621;4946.406431228275;4949.737816856678;4956.256561515657;4964.946557866813;4605.37827393311;4847.636427267898;4867.7322747249245;4880.267959805916;4891.559759621651 14:30:59 INFO - PROCESS | 5372 | |5;yui.html;642.7718160053181;653.8528831013019;667.2626747444074;672.9495287853412;691.671456058372;12886.935565322172;13446.663833404145;13856.237906915128;13899.166050037005;13904.721905561883;13345.733085338288;13363;13484.258365789901;13541.119827211225;13572.524961626345;763.1071646173976;783.3928705253417;786.2530595933886;786.5005721366945;786.6735304848481;614.4715544631613;635.8156134720925;743.31614914279;785.3363907498183;794.9006374203225;816.6325153680838;817.0154963269276;817.995910020452;818.4598165210962;818.607068607069;811.6063709101081;811.930985866202;812.1796985045117;812.5937031484258;812.6749300279877;477.512936804461;487.75124686409833;489.75512243878063;492.7634735327063;492.95070492950776;11739.119566032581;12141.878581214252;12305.507779688802;12722.10945233834;12791.48834046637;13018.283994380305;13835.584932452042;13847.169169849842;14094.718105637932;14393.71212575753;9788.427982233508;9957.0540798624;9995.500224988722;10131;10322.225833062475;3332.350191712617;3362.06939287433;3387.9661203387896;3445.0526105320987;3513.2095278562374;63838;64805.67597161984;67529.24653747914;67538.66230668864;67709.66145169243;10523.21075919309;10577.524011419504;10602.575896964036;10773.407462589475;10794.78410431787;20427.693584596243;20547.38357849267;20614.17543298281;21084.47288817792;21444.892775536024;6881.311868813179;6928.688209030605;6929.792106236821;7064.576125432491;7104.822379440452;3636.454531820248;3650.7444478886755;3661.176235347079;3710.18375957289;3712.9814350928614;2866.426714657077;2937.5593660951026;2938.397628486155;2960.259935016246;2967.7774166937565;479.0729937570812;484.7309743092547;493.6026498668534;495.76946719775475;503.1547001038291;564.7430419159273;572.8338781753245;588.2000479348084;589.8820235952741;645.8643684826145;8493.660253589787;8539;8636.481811091355;8717.084706105768;8900.643974241088;589.0473081734038;593.0274350065895;598.628850112924;600.9128676341905;609.1989034419723;3980.7611543306916;3999;4193.329067349209;4197.853075142417;4217.40956266123;58980;59072.40927590669;74499.62750186323;105467;105521;89101;89761;90269.99999999869;90301.67888247891;90602.54698726464;76873;77462.22537774662;77966;78115.60942195253;80087.59956200299;7850.528968261922;7955.323797477279;7976.441649084509;7992.200779921961;8143.714969976022;45162.548374515834;45613.77193114013;45934.31098533458;46400.30399543942;46437.76781116208;60922;61399;67515.649687005;67539.66230168818;68511;10802.459877006275;10840.403777791982;10925.399103049409;11006.559737610405;11361.455417832933;11325;11577.412539551715;11653.941730291293;11911.225770324902;12038.578649747216;10546;10578.365298082139;10818.729531761768;11268.267562608733;11309.095272378025;10727.624533141303;10886.23796334249;11054.723631909266;11081.335119892832;11121.666350009513;9792.951035244778;10080.395176289447;10312.48437578133;10669.46652667348;10739.624113156002;8413.242808147295;8442.32461403074;8773.298136148966;8801.779955500908;9157.175854173156;8833.911660883567;9211.501444892512;9244.583993720433;9326.347155699035;9497.572609232462 14:30:59 INFO - PROCESS | 5372 | __end_tp_report 14:30:59 INFO - PROCESS | 5372 | __start_cc_report 14:30:59 INFO - PROCESS | 5372 | _x_x_mozilla_cycle_collect,1673 14:30:59 INFO - PROCESS | 5372 | __end_cc_report 14:30:59 INFO - PROCESS | 5372 | __startTimestamp1476394258989__endTimestamp 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | ------- Summary: start ------- 14:30:59 INFO - PROCESS | 5372 | Number of tests: 6 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#0] dojo.html Cycles:165 Average:4715.45 Median:4877.17 stddev:495.41 (10.2%) stddev-sans-first:465.60 14:30:59 INFO - PROCESS | 5372 | Values: 2505.1 2580.0 2613.7 2615.5 2636.7 4526.3 4628.6 4685.5 4704.4 4709.7 4644.9 4782.2 4840.8 4877.2 4901.4 4346.7 4403.2 4454.2 4454.3 4480.6 4431.7 4518.5 4550.5 4563.0 4598.0 4215.7 4488.9 4494.2 4535.8 4607.3 4303.1 4380.1 4422.3 4453.5 4483.3 4437.0 4444.7 4455.5 4493.3 4509.5 4766.6 4810.8 4839.1 4840.1 4892.6 4876.1 4939.4 4946.4 5071.4 5153.6 5143.8 5170.2 5170.2 5215.3 5231.4 4786.5 4793.2 4796.9 4799.3 4859.7 4989.9 5043.2 5257.8 5261.6 5264.3 4895.1 4918.3 4936.2 4937.1 5022.4 5017.9 5038.2 5045.3 5050.5 5104.6 4976.2 4997.1 5019.4 5019.7 5035.9 4858.4 4908.4 4915.7 4973.3 4975.5 4184.5 4194.1 4194.4 4199.1 4225.4 3709.8 3709.8 3742.0 3744.0 3775.6 4431.8 4438.6 4440.1 4442.4 4495.8 4903.3 4905.5 4958.7 5079.6 5141.5 4444.3 4515.8 4518.7 4535.4 4600.3 4609.3 4632.4 4634.6 4636.5 4645.8 4698.3 4934.7 4935.5 4936.5 5001.3 4980.8 5000.5 5051.1 5103.6 5146.7 4894.8 4906.0 4912.1 4950.1 4971.4 5100.8 5108.6 5110.6 5113.1 5178.2 4832.0 4861.0 4879.1 5152.8 5179.2 5039.3 5041.7 5077.5 5092.7 5101.5 5041.2 5041.9 5043.1 5044.5 5060.9 4649.9 4653.0 4952.2 4961.9 4964.5 4843.1 4976.8 5018.8 5019.2 5098.1 4741.5 4793.2 4907.8 4924.0 4990.8 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#1] ext.html Cycles:180 Average:44280.17 Median:35849.55 stddev:75943.22 (211.8%) stddev-sans-first:76085.26 14:30:59 INFO - PROCESS | 5372 | Values: 543.6 556.9 564.3 566.4 576.1 27441.9 37441.3 38234.0 38279.6 41795.8 39097.0 39502.4 39518.2 39596.0 39625.2 7694.2 7818.1 7837.2 7843.4 7845.4 7623.9 7694.5 7705.2 7708.7 7719.5 7697.4 7743.3 7747.1 7753.2 7763.0 7702.4 7718.8 7733.5 7745.7 7750.5 7623.3 7692.2 7698.4 7699.3 7699.9 37141.4 37494.1 37499.0 37502.8 37518.4 3002.5 3124.9 3216.0 3330.7 3379.7 27857.7 28108.9 28324.7 28449.7 28555.1 3248.5 3285.4 3356.9 3361.1 3448.3 229788.0 230257.0 230537.0 230656.0 232348.0 52028.5 52365.2 52427.2 52450.0 52531.5 54549.2 54551.0 54615.5 54648.7 54651.5 14568.6 14686.7 14704.0 14774.5 14776.9 11349.2 11368.1 11380.4 11385.7 11388.3 15359.4 16029.0 16050.4 16066.4 16151.8 5904.5 5941.2 5976.6 6009.2 6288.6 671.2 698.7 713.4 876.3 903.1 27523.7 27908.7 28318.0 28423.9 28435.1 902.9 920.8 936.0 953.4 996.9 14388.2 14605.8 14903.0 14998.3 15083.3 352914.0 357436.0 357660.6 357688.0 358286.0 47943.3 47980.8 48062.5 48079.0 48131.0 1059.6 1081.4 1139.3 1150.4 1157.8 27106.9 27111.5 28404.1 29097.9 29509.4 43490.3 46732.5 46767.5 46842.0 46859.8 263149.0 265064.0 266046.0 267376.0 267647.0 24262.3 24589.0 25083.0 25100.0 26264.0 41059.6 41124.6 41170.2 42215.6 42790.0 35764.8 35830.3 35988.6 36040.1 36650.5 34971.8 34974.3 35411.8 35506.0 35868.8 34293.8 34759.7 35073.3 35529.6 35882.6 30093.8 32192.0 32362.7 32479.5 32592.8 24474.3 24704.1 24721.8 25021.7 25083.2 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#2] jquery.html Cycles:180 Average:22476.52 Median:4882.36 stddev:58623.32 (1200.7%) stddev-sans-first:58764.22 14:30:59 INFO - PROCESS | 5372 | Values: 342.8 369.2 373.7 377.5 393.5 12212.9 12298.9 13169.4 13169.7 16801.2 16172.2 16530.5 16532.9 16652.2 16666.0 4870.5 4894.2 5124.9 5158.4 5159.2 3562.1 3768.7 5062.1 5149.2 5153.6 3745.8 3746.7 3757.8 3788.6 3882.6 5841.7 5996.0 6000.5 6002.1 6009.7 5073.8 5262.7 5321.8 5328.8 5334.4 19395.7 19432.6 19471.7 19615.6 19616.8 1880.6 1909.3 1986.6 2154.4 2229.6 12486.4 12541.8 12709.2 12725.5 13407.8 1657.6 1676.8 1680.9 1690.4 1723.8 68188.7 69332.7 69337.7 69469.3 69762.0 9152.2 9233.9 9315.3 9463.1 9757.3 13038.2 13067.5 13088.3 13110.2 13118.8 6936.4 7194.5 7210.9 7328.5 7374.1 7069.7 7157.4 7162.0 7167.9 7460.8 5766.1 5889.1 5906.5 6006.5 6130.2 1679.4 1712.7 1720.4 1721.7 1777.9 824.1 837.1 852.4 906.3 922.5 16262.5 16421.3 16564.2 16738.4 17198.5 843.2 845.8 852.5 906.0 933.5 9408.8 9456.1 9676.5 9887.0 9986.8 306817.0 306968.0 370140.0 373467.0 404409.0 58178.0 66534.3 67817.7 68391.0 81151.0 423.3 441.1 442.8 445.2 446.0 9440.5 9480.3 9844.4 10065.5 10354.3 24542.4 25945.6 32267.7 33403.3 34041.0 46895.3 46990.3 50513.0 51227.0 52421.2 7274.5 7334.9 7584.8 7841.1 8047.6 6803.6 9974.6 10155.5 10850.9 11663.3 9625.0 9885.9 9978.6 10149.8 10312.2 9737.8 10003.7 10135.0 10280.4 10305.1 9987.8 10457.4 10497.5 10571.0 10987.0 7246.2 7646.3 7774.4 7808.2 8061.5 9589.9 9673.8 9737.9 9906.7 10196.9 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#3] mootools.html Cycles:180 Average:5179.61 Median:5422.58 stddev:2916.73 (53.8%) stddev-sans-first:2910.47 14:30:59 INFO - PROCESS | 5372 | Values: 1317.4 1367.2 1422.6 1629.3 1678.2 7410.5 8024.9 8027.7 8040.2 8041.1 6497.3 6758.6 7529.5 7790.8 7795.3 2177.8 2210.9 2210.9 2211.1 2212.0 2144.8 2172.7 2211.8 2212.8 2219.3 1801.3 1886.3 2073.9 2163.0 2166.7 2182.7 2183.4 2200.4 2201.6 2202.5 2178.9 2179.5 2183.9 2184.3 2196.5 7815.4 7983.4 7993.4 7994.0 8002.4 4588.1 4755.0 4767.0 4774.0 4788.2 2816.3 2850.0 2856.1 3000.3 3066.0 859.7 895.9 909.9 917.3 919.8 10941.4 10954.2 10978.6 10981.1 10999.7 3991.9 4307.5 4329.1 4404.7 4440.8 9297.3 9313.1 9317.9 9323.1 9325.1 4778.1 4803.1 4804.3 4811.7 4813.5 4095.4 4370.5 4382.4 4383.3 4388.5 3357.9 3365.5 3468.6 3473.4 3512.7 1050.6 1054.9 1059.9 1062.8 1070.3 660.9 709.2 791.8 819.3 822.5 5328.6 5417.7 5427.2 5503.4 5649.5 802.5 851.8 864.7 877.5 925.7 3704.9 3709.8 3752.6 3757.8 3891.9 9430.9 9622.9 9811.3 9967.4 9978.4 9868.0 9884.5 9897.2 9899.1 9899.1 7297.3 7380.1 7398.5 7415.7 7444.9 5352.5 5364.4 5409.1 5418.0 5556.0 8847.3 8931.5 8946.5 8979.6 9056.9 8234.2 8581.2 8591.8 8831.8 9100.9 6581.1 6700.1 6719.8 6719.9 6762.1 7375.7 7452.1 7453.0 7457.7 7459.7 6642.2 6799.8 6828.8 6870.3 6985.0 6673.6 6679.2 6722.3 6775.4 6799.7 6233.8 6298.5 6337.7 6355.4 6359.9 4501.1 4688.1 4772.2 4782.3 4864.3 4531.1 4564.4 4626.0 4693.3 4734.3 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#4] prototype.html Cycles:180 Average:4068.99 Median:4598.44 stddev:1176.74 (25.6%) stddev-sans-first:1145.36 14:30:59 INFO - PROCESS | 5372 | Values: 290.8 296.1 303.7 308.6 308.6 4704.7 4733.5 4737.7 4738.0 4746.6 4651.7 4656.8 4680.7 4681.4 4682.1 3745.0 3749.6 3751.5 3751.7 3757.2 3521.6 3765.9 3772.4 3772.7 3778.8 3697.5 3750.0 3757.9 3764.3 3770.2 3738.3 3739.8 3745.7 3747.9 3748.6 3156.8 3212.7 3248.5 3345.3 3351.4 4568.8 4569.5 4572.9 4574.5 4603.4 4180.4 4232.5 4233.4 4233.8 4249.9 4593.4 4615.4 4860.2 4871.5 4882.7 3574.4 3576.0 3585.5 3591.4 3593.5 5089.6 5127.8 5136.3 5139.9 5140.8 3606.7 3701.5 3714.4 3715.5 3722.3 3746.3 3763.4 3767.4 3778.5 3782.0 4218.2 4228.3 4230.7 4231.0 4239.3 4910.4 4915.5 4919.0 4921.2 4933.2 1249.9 1294.7 1297.2 1305.1 1316.8 836.9 847.8 863.0 863.3 865.1 3971.4 3986.2 3992.7 3993.4 4011.8 4441.5 4451.9 4463.0 4477.7 4502.8 3947.3 3956.0 3966.6 3983.2 3988.7 2295.4 2324.7 2329.9 2359.6 2390.8 4256.6 4615.7 4659.4 4720.4 4849.6 5194.2 5198.6 5205.3 5213.6 5218.4 4774.5 4795.0 4813.7 4822.2 4852.6 4938.9 4946.1 5039.6 5062.4 5072.3 4941.9 5018.3 5027.5 5034.6 5041.2 4846.5 4856.5 4856.9 4858.0 4860.3 3609.9 3696.5 3713.2 3737.0 3763.6 5072.8 5081.6 5084.2 5102.1 5127.0 4887.0 4942.0 4946.2 4951.5 4953.4 4678.5 4905.3 4916.3 4933.4 4938.3 4834.5 4851.3 4852.0 4853.6 4862.4 4945.8 4946.4 4949.7 4956.3 4964.9 4605.4 4847.6 4867.7 4880.3 4891.6 14:30:59 INFO - PROCESS | 5372 | 14:30:59 INFO - PROCESS | 5372 | [#5] yui.html Cycles:180 Average:17707.98 Median:494.69 stddev:25345.75 (5123.6%) stddev-sans-first:25384.46 14:30:59 INFO - PROCESS | 5372 | Values: 642.8 653.9 667.3 672.9 691.7 12886.9 13446.7 13856.2 13899.2 13904.7 13345.7 13363.0 13484.3 13541.1 13572.5 763.1 783.4 786.3 786.5 786.7 614.5 635.8 743.3 785.3 794.9 816.6 817.0 818.0 818.5 818.6 811.6 811.9 812.2 812.6 812.7 477.5 487.8 489.8 492.8 493.0 11739.1 12141.9 12305.5 12722.1 12791.5 13018.3 13835.6 13847.2 14094.7 14393.7 9788.4 9957.1 9995.5 10131.0 10322.2 3332.4 3362.1 3388.0 3445.1 3513.2 63838.0 64805.7 67529.2 67538.7 67709.7 10523.2 10577.5 10602.6 10773.4 10794.8 20427.7 20547.4 20614.2 21084.5 21444.9 6881.3 6928.7 6929.8 7064.6 7104.8 3636.5 3650.7 3661.2 3710.2 3713.0 2866.4 2937.6 2938.4 2960.3 2967.8 479.1 484.7 493.6 495.8 503.2 564.7 572.8 588.2 589.9 645.9 8493.7 8539.0 8636.5 8717.1 8900.6 589.0 593.0 598.6 600.9 609.2 3980.8 3999.0 4193.3 4197.9 4217.4 58980.0 59072.4 74499.6 105467.0 105521.0 89101.0 89761.0 90270.0 90301.7 90602.5 76873.0 77462.2 77966.0 78115.6 80087.6 7850.5 7955.3 7976.4 7992.2 8143.7 45162.5 45613.8 45934.3 46400.3 46437.8 60922.0 61399.0 67515.6 67539.7 68511.0 10802.5 10840.4 10925.4 11006.6 11361.5 11325.0 11577.4 11653.9 11911.2 12038.6 10546.0 10578.4 10818.7 11268.3 11309.1 10727.6 10886.2 11054.7 11081.3 11121.7 9793.0 10080.4 10312.5 10669.5 10739.6 8413.2 8442.3 8773.3 8801.8 9157.2 8833.9 9211.5 9244.6 9326.3 9497.6 14:30:59 INFO - PROCESS | 5372 | -------- Summary: end -------- 14:30:59 INFO - PROCESS | 5372 | 14:31:00 INFO - TEST-INFO | 5372: exit 0 14:31:00 INFO - TEST-OK | dromaeo_css | took 1122261ms 14:31:00 INFO - TEST-START | kraken 14:31:00 INFO - operating with platform_type : linux_ 14:31:00 INFO - Initialising browser for kraken test... 14:31:00 INFO - TEST-INFO | started process 5679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqueSjI/profile http://localhost:60232/getInfo.html) 14:31:04 INFO - PROCESS | 5679 | __metrics Screen width/height:1600/1200 14:31:04 INFO - PROCESS | 5679 | colorDepth:24 14:31:04 INFO - PROCESS | 5679 | Browser inner width/height: 1024/697 14:31:04 INFO - PROCESS | 5679 | __metrics 14:31:04 INFO - PROCESS | 5679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:31:04 INFO - PROCESS | 5679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:05 INFO - PROCESS | 5679 | console.error: PushService: 14:31:05 INFO - PROCESS | 5679 | stateChangeProcessEnqueue: Error transitioning state 14:31:05 INFO - PROCESS | 5679 | UnknownError 14:31:06 INFO - TEST-INFO | 5679: exit 0 14:31:06 INFO - Browser initialized. 14:31:06 INFO - Running cycle 1/1 for kraken test... 14:31:06 INFO - TEST-INFO | started process 5761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqueSjI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:18 INFO - PROCESS | 5761 | RSS: Main: 174694400 14:31:18 INFO - PROCESS | 5761 | 14:31:21 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60232/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:22 INFO - PROCESS | 5761 | RSS: Main: 241754112 14:31:22 INFO - PROCESS | 5761 | 14:31:25 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60232/tests/kraken/driver.html?testName=audio-dft) 14:31:25 INFO - PROCESS | 5761 | RSS: Main: 218759168 14:31:25 INFO - PROCESS | 5761 | 14:31:28 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60232/tests/kraken/driver.html?testName=audio-fft) 14:31:29 INFO - PROCESS | 5761 | RSS: Main: 300834816 14:31:29 INFO - PROCESS | 5761 | 14:31:31 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60232/tests/kraken/driver.html?testName=audio-oscillator) 14:31:32 INFO - PROCESS | 5761 | RSS: Main: 211177472 14:31:32 INFO - PROCESS | 5761 | 14:31:34 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60232/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:35 INFO - PROCESS | 5761 | RSS: Main: 214310912 14:31:35 INFO - PROCESS | 5761 | 14:31:38 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60232/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:39 INFO - PROCESS | 5761 | RSS: Main: 250019840 14:31:39 INFO - PROCESS | 5761 | 14:31:42 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60232/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:43 INFO - PROCESS | 5761 | RSS: Main: 249495552 14:31:43 INFO - PROCESS | 5761 | 14:31:45 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60232/tests/kraken/driver.html?testName=json-parse-financial) 14:31:46 INFO - PROCESS | 5761 | RSS: Main: 248963072 14:31:46 INFO - PROCESS | 5761 | 14:31:48 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60232/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:48 INFO - PROCESS | 5761 | RSS: Main: 211546112 14:31:48 INFO - PROCESS | 5761 | 14:31:50 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:51 INFO - PROCESS | 5761 | RSS: Main: 218148864 14:31:51 INFO - PROCESS | 5761 | 14:31:53 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:54 INFO - PROCESS | 5761 | RSS: Main: 227360768 14:31:54 INFO - PROCESS | 5761 | 14:31:57 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:57 INFO - PROCESS | 5761 | RSS: Main: 236019712 14:31:57 INFO - PROCESS | 5761 | 14:32:00 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:01 INFO - PROCESS | 5761 | RSS: Main: 233103360 14:32:01 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | Cycle 1(1): loaded http://localhost:60232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60232/tests/kraken/driver.html?testName=ai-astar) 14:32:03 INFO - PROCESS | 5761 | RSS: Main: 283357184 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | __start_tp_report 14:32:03 INFO - PROCESS | 5761 | _x_x_mozilla_page_load 14:32:03 INFO - PROCESS | 5761 | _x_x_mozilla_page_load_details 14:32:03 INFO - PROCESS | 5761 | |i|pagename|runs| 14:32:03 INFO - PROCESS | 5761 | |0;ai-astar;110;112;115;112;112;113;114;111;113;113 14:32:03 INFO - PROCESS | 5761 | |1;audio-beat-detection;155;132;126;170;133;126;127;127;169;143 14:32:03 INFO - PROCESS | 5761 | |2;audio-dft;162;162;163;161;162;160;162;161;161;161 14:32:03 INFO - PROCESS | 5761 | |3;audio-fft;76;78;76;112;77;77;77;76;99;76 14:32:03 INFO - PROCESS | 5761 | |4;audio-oscillator;85;84;114;85;83;82;107;84;84;115 14:32:03 INFO - PROCESS | 5761 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 14:32:03 INFO - PROCESS | 5761 | |6;imaging-darkroom;146;146;146;146;146;146;145;147;147;147 14:32:03 INFO - PROCESS | 5761 | |7;imaging-desaturate;96;95;95;95;95;96;95;94;94;95 14:32:03 INFO - PROCESS | 5761 | |8;json-parse-financial;66;64;63;64;64;66;67;67;66;68 14:32:03 INFO - PROCESS | 5761 | |9;json-stringify-tinderbox;66;66;66;66;66;66;67;67;66;67 14:32:03 INFO - PROCESS | 5761 | |10;stanford-crypto-aes;82;83;88;83;83;83;94;84;82;83 14:32:03 INFO - PROCESS | 5761 | |11;stanford-crypto-ccm;143;159;139;148;138;136;137;145;180;141 14:32:03 INFO - PROCESS | 5761 | |12;stanford-crypto-pbkdf2;176;177;174;175;184;182;183;176;173;178 14:32:03 INFO - PROCESS | 5761 | |13;stanford-crypto-sha256-iterative;70;71;70;71;72;71;70;71;71;69 14:32:03 INFO - PROCESS | 5761 | __end_tp_report 14:32:03 INFO - PROCESS | 5761 | __start_cc_report 14:32:03 INFO - PROCESS | 5761 | _x_x_mozilla_cycle_collect,1978 14:32:03 INFO - PROCESS | 5761 | __end_cc_report 14:32:03 INFO - PROCESS | 5761 | __startTimestamp1476394323522__endTimestamp 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | ------- Summary: start ------- 14:32:03 INFO - PROCESS | 5761 | Number of tests: 14 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.43 (1.3%) stddev-sans-first:1.20 14:32:03 INFO - PROCESS | 5761 | Values: 110.0 112.0 115.0 112.0 112.0 113.0 114.0 111.0 113.0 113.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:138.00 stddev:17.67 (12.8%) stddev-sans-first:17.98 14:32:03 INFO - PROCESS | 5761 | Values: 155.0 132.0 126.0 170.0 133.0 126.0 127.0 127.0 169.0 143.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 14:32:03 INFO - PROCESS | 5761 | Values: 162.0 162.0 163.0 161.0 162.0 160.0 162.0 161.0 161.0 161.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:12.57 (16.3%) stddev-sans-first:13.12 14:32:03 INFO - PROCESS | 5761 | Values: 76.0 78.0 76.0 112.0 77.0 77.0 77.0 76.0 99.0 76.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:84.00 stddev:13.78 (16.4%) stddev-sans-first:14.36 14:32:03 INFO - PROCESS | 5761 | Values: 85.0 84.0 114.0 85.0 83.0 82.0 107.0 84.0 84.0 115.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:32:03 INFO - PROCESS | 5761 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:32:03 INFO - PROCESS | 5761 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 147.0 147.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 14:32:03 INFO - PROCESS | 5761 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 94.0 95.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.74 14:32:03 INFO - PROCESS | 5761 | Values: 66.0 64.0 63.0 64.0 64.0 66.0 67.0 67.0 66.0 68.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:32:03 INFO - PROCESS | 5761 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:3.75 (4.5%) stddev-sans-first:3.87 14:32:03 INFO - PROCESS | 5761 | Values: 82.0 83.0 88.0 83.0 83.0 83.0 94.0 84.0 82.0 83.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:144.00 stddev:13.56 (9.4%) stddev-sans-first:14.32 14:32:03 INFO - PROCESS | 5761 | Values: 143.0 159.0 139.0 148.0 138.0 136.0 137.0 145.0 180.0 141.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:177.50 stddev:3.88 (2.2%) stddev-sans-first:4.06 14:32:03 INFO - PROCESS | 5761 | Values: 176.0 177.0 174.0 175.0 184.0 182.0 183.0 176.0 173.0 178.0 14:32:03 INFO - PROCESS | 5761 | 14:32:03 INFO - PROCESS | 5761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 14:32:03 INFO - PROCESS | 5761 | Values: 70.0 71.0 70.0 71.0 72.0 71.0 70.0 71.0 71.0 69.0 14:32:03 INFO - PROCESS | 5761 | -------- Summary: end -------- 14:32:03 INFO - PROCESS | 5761 | 14:32:04 INFO - TEST-INFO | 5761: exit 0 14:32:04 INFO - TEST-OK | kraken | took 64825ms 14:32:04 INFO - SUITE-END | took 1187s 14:32:05 INFO - Completed test suite (00:19:47) 14:32:05 INFO - javascript benchmark 14:32:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2505.13572817378, 2579.974200257997, 2613.7255588163243, 2615.50305441966, 2636.6704161979765, 4526.343680166374, 4628.606568441686, 4685.508021657728, 4704.435467743871, 4709.670323077382, 4644.930326045112, 4782.210935195697, 4840.757962101899, 4877.170880950238, 4901.362822833035, 4346.6739994500385, 4403.185410699031, 4454.242778727608, 4454.287314029756, 4480.551944805509, 4431.689781715281, 4518.471960332417, 4550.476695180047, 4562.954370456303, 4597.954020459802, 4215.725977811432, 4488.910221795579, 4494.235979883428, 4535.750533720644, 4607.331936869152, 4303.117860838521, 4380.058287468178, 4422.29243321067, 4453.465584129893, 4483.282674772054, 4436.9556304436865, 4444.666650001231, 4455.487618923833, 4493.348464472633, 4509.549045095497, 4766.594839438617, 4810.831620893252, 4839.104765618336, 4840.128776820171, 4892.584130348924, 4876.097921884463, 4939.431965323962, 4946.3817022872145, 5071.416787069497, 5153.613478989091, 5143.819966301162, 5170.172772356443, 5170.224466330081, 5215.322008138917, 5231.424543300234, 4786.5452781985305, 4793.209120495079, 4796.904061918742, 4799.328094066834, 4859.659823812299, 4989.90020199594, 5043.167877300278, 5257.842264732064, 5261.579073674096, 5264.289320941701, 4895.143349913751, 4918.311436398907, 4936.234883593049, 4937.1113199624415, 5022.422421421583, 5017.9247311290355, 5038.244263360452, 5045.293658887758, 5050.49495050492, 5104.642675012788, 4976.154053810861, 4997.075541024922, 5019.372578427697, 5019.67372120811, 5035.899282014339, 4858.368412106403, 4908.435529914034, 4915.65590408668, 4973.278874563168, 4975.527324904128, 4184.476940382452, 4194.098268872207, 4194.412782210493, 4199.076203235283, 4225.408442817947, 3709.795961222159, 3709.8145092745794, 3742.0270729610497, 3743.981280093582, 3775.622437756257, 4431.778411079497, 4438.622717069021, 4440.067585806952, 4442.355858400514, 4495.842645507457, 4903.289023091632, 4905.484924082992, 4958.7024778513405, 5079.644424890223, 5141.53726164647, 4444.3333499974615, 4515.796789144496, 4518.728876267434, 4535.387722657465, 4600.332951721982, 4609.285560738091, 4632.444106707149, 4634.629229661619, 4636.536346365404, 4645.814167433265, 4698.318743782064, 4934.7285899275885, 4935.457099719028, 4936.481669424658, 5001.349824522861, 4980.800767969386, 5000.524950129732, 5051.06555287273, 5103.617228707936, 5146.665466744649, 4894.779734911866, 4905.950940490692, 4912.140375434356, 4950.059488697136, 4971.428285747185, 5100.770465328995, 5108.61685373591, 5110.642255042111, 5113.079645663667, 5178.249153872743, 4832.009438065118, 4860.95139048605, 4879.121758083579, 5152.76812543444, 5179.171332586768, 5039.3448851649055, 5041.747912604428, 5077.492250774893, 5092.745362731775, 5101.464346243591, 5041.2438134280155, 5041.924371134362, 5043.142665746758, 5044.495550444926, 5060.949390506048, 4649.883752906205, 4652.953470465252, 4952.1581331173065, 4961.900761984813, 4964.478729733326, 4843.07981483517, 4976.776045078052, 5018.824341148043, 5019.222020586815, 5098.082345177755, 4741.5021422750115, 4793.18515852299, 4907.77914993819, 4923.975380123076, 4990.775415106402], "value": 4683.164393033496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5868739757784, 556.8607848037988, 564.272089005183, 566.365670449097, 576.0753989846294, 27441.862790686042, 37441.25117497648, 38233.99999999996, 38279.61720382802, 41795.79102104485, 39097.0, 39502.40746388799, 39518.20963580727, 39596.0, 39625.20749585007, 7694.153643099268, 7818.14000459949, 7837.216278372174, 7843.372530197599, 7845.411594130434, 7623.923760762377, 7694.5383277003275, 7705.229477052306, 7708.653110610036, 7719.49823261489, 7697.422693297997, 7743.341815945651, 7747.070351557821, 7753.185915478878, 7762.9611851940945, 7702.42231832612, 7718.807029824243, 7733.45865789395, 7745.7288994885475, 7750.534967901887, 7623.313901748814, 7692.192319806451, 7698.384129269701, 7699.345555627779, 7699.884501732478, 37141.442878356844, 37494.06264843373, 37499.0, 37502.81248593739, 37518.43722344167, 3002.459557279689, 3124.9218769530717, 3215.951760723591, 3330.6502817204087, 3379.7465190110593, 27857.721422785715, 28108.85945570259, 28324.71675283262, 28449.715502844912, 28555.143345699664, 3248.496483045108, 3285.375778602082, 3356.8825091121694, 3361.126107212118, 3448.327576122657, 229788.0, 230256.9999999983, 230537.0, 230656.0, 232348.0, 52028.47971520312, 52365.21452178144, 52427.21359179616, 52450.0, 52531.47468525342, 54549.1817622736, 54551.0, 54615.45384546104, 54648.726756366756, 54651.453485465434, 14568.63578410527, 14686.706265874836, 14704.0, 14774.48289309869, 14776.926115369355, 11349.162709322669, 11368.147388945863, 11380.430978451044, 11385.715357115972, 11388.316700997966, 15359.385624574892, 16029.0, 16050.357985680675, 16066.43767468133, 16151.757723634155, 5904.498117660047, 5941.197938278277, 5976.581639285208, 6009.1587177795145, 6288.591241569284, 671.2012704881175, 698.72400401842, 713.4328209073695, 876.3164731509432, 903.1010456434917, 27523.724762752117, 27908.720912791017, 28318.0, 28423.85788071088, 28435.146945591667, 902.9232515236279, 920.8204400141908, 935.9906400935904, 953.413650604873, 996.8903420623726, 14388.208648524222, 14605.78091328631, 14903.0, 14998.325075371635, 15083.321250543751, 352914.0, 357436.0, 357660.63509047386, 357688.0, 358286.0, 47943.28085078727, 47980.760096199294, 48062.51937480651, 48079.0, 48131.0, 1059.6450189186555, 1081.405227125078, 1139.2651739627893, 1150.3730466895563, 1157.7568710570706, 27106.864465677547, 27111.457770844867, 28404.147875563765, 29097.85451072731, 29509.409811804075, 43490.34764478472, 46732.53267467282, 46767.532324676315, 46842.0, 46859.76570117127, 263149.0, 265064.0, 266046.0, 267376.0, 267647.0, 24262.30163888511, 24589.0, 25083.0, 25100.0, 26264.0, 41059.58940410558, 41124.588754112076, 41170.176596468504, 42215.5778442224, 42790.0, 35764.821175895, 35830.28339433249, 35988.64011359853, 36040.098997525274, 36650.45024324691, 34971.82514087515, 34974.300513990085, 35411.82294088513, 35506.0, 35868.820655896554, 34293.82853085719, 34759.652403475644, 35073.29853402969, 35529.644703552636, 35882.64117358793, 30093.849530752206, 32192.0, 32362.676373235965, 32479.512807307437, 32592.837035814668, 24474.26577202687, 24704.13535526248, 24721.752782471944, 25021.74978250194, 25083.24750257495], "value": 17008.21907159383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.75493022488916, 369.1969965325417, 373.74585282008235, 377.5205489028933, 393.49435974772405, 12212.877871221284, 12298.877011229884, 13169.407376668061, 13169.736605267914, 16801.243944022517, 16172.19139043046, 16530.504084877444, 16532.917335413305, 16652.16739163043, 16666.0, 4870.4885986971385, 4894.241392584137, 5124.948750512484, 5158.380994280692, 5159.22611608258, 3562.073860796199, 3768.6796622287, 5062.139436295838, 5149.150390185615, 5153.56194723449, 3745.793981331026, 3746.662800347968, 3757.7933213673236, 3788.602196769341, 3882.646875475506, 5841.707914604252, 5996.040633498619, 6000.519958403339, 6002.099685047234, 6009.729562169713, 5073.847784566469, 5262.736863156827, 5321.760520776575, 5328.786848526054, 5334.4398838122215, 19395.709064364044, 19432.611347773105, 19471.707924381146, 19615.607687846306, 19616.80383196164, 1880.6332765110808, 1909.255390397746, 1986.5728868293243, 2154.396768904709, 2229.6321107017325, 12486.375681215903, 12541.811872821914, 12709.17390369623, 12725.490980360775, 13407.798883016763, 1657.5856035991003, 1676.8490835824712, 1680.882338236324, 1690.4194578069544, 1723.7672914156553, 68188.6590567049, 69332.65333673349, 69337.65331173362, 69469.30530694679, 69762.0, 9152.17630413266, 9233.938097118917, 9315.254779617615, 9463.066449400707, 9757.268204884662, 13038.217706937614, 13067.477300907858, 13088.345582720825, 13110.213387196798, 13118.803217951738, 6936.410405115521, 7194.532355396883, 7210.927890721131, 7328.450366222448, 7374.115106187184, 7069.717211311593, 7157.355837974607, 7161.9641901790155, 7167.89248161278, 7460.813479663052, 5766.135079738073, 5889.114333976407, 5906.497947674496, 6006.489448396847, 6130.2030736004035, 1679.4038116468478, 1712.7259638458036, 1720.3656526300065, 1721.672882152387, 1777.9111044447725, 824.085265355455, 837.1042984007054, 852.4373913217247, 906.3157316226207, 922.5341202692731, 16262.51212463628, 16421.261043253082, 16564.171791410383, 16738.414155504743, 17198.484045478657, 843.1736897840028, 845.8350621628723, 852.5268475995758, 906.0486489186328, 933.4819175357605, 9408.811823763486, 9456.148946594702, 9676.516174191262, 9886.950565247127, 9986.800263994824, 306817.0, 306968.0, 370140.0, 373467.0, 404409.0, 58178.0, 66534.33465665378, 67817.66091169513, 68391.0, 81151.0, 423.2656341247932, 441.1441802902359, 442.80073966715105, 445.23864192231, 446.00985811497776, 9440.527973601154, 9480.288978326515, 9844.3601165924, 10065.547050382896, 10354.256122127492, 24542.386440339134, 25945.610815838154, 32267.677323226468, 33403.331933360714, 34041.0, 46895.29657055215, 46990.30679324336, 50513.0, 51227.0, 52421.21368179557, 7274.4907856449545, 7334.853302933805, 7584.772456826304, 7841.098273698598, 8047.597620118853, 6803.591784492946, 9974.551145198338, 10155.492225388849, 10850.891491085304, 11663.300201987908, 9624.951875240578, 9885.901140988499, 9978.550965206729, 10149.84775228387, 10312.175025998053, 9737.805243895224, 10003.699889003341, 10135.0, 10280.434576098387, 10305.124064454305, 9987.750306242402, 10457.424841633783, 10497.47512624381, 10571.0, 10987.0, 7246.239144889711, 7646.311831935152, 7774.416918731004, 7808.180141085331, 8061.516309021477, 9589.904100958902, 9673.758156045873, 9737.9026209737, 9906.702798916043, 10196.898031019891], "value": 7744.362549438906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.4400879626157, 1367.2275164532039, 1422.5803388000538, 1629.291258302639, 1678.1693061934345, 7410.4812663113535, 8024.879626805603, 8027.678892844294, 8040.2361775631225, 8041.1154772975, 6497.285298617148, 6758.628275444848, 7529.548227106377, 7790.8441831163345, 7795.298423141916, 2177.77133400993, 2210.8673479591275, 2210.9447263818374, 2211.0602993727603, 2212.0, 2144.764075951644, 2172.73927128744, 2211.8119959803435, 2212.7676593957644, 2219.3341997400794, 1801.2524802207133, 1886.3397810766191, 2073.8651987620833, 2163.026638012893, 2166.696662467248, 2182.68351089092, 2183.4213933307688, 2200.3618950504415, 2201.570693714726, 2202.493426511895, 2178.923737669174, 2179.5422961178174, 2183.912643494258, 2184.2791878680155, 2196.4728465168405, 7815.374770018385, 7983.441159118864, 7993.400494962901, 7993.960030199812, 8002.399820013464, 4588.105319462706, 4754.976225118887, 4767.046590681843, 4774.0, 4788.209945359012, 2816.3100040490212, 2849.957250641242, 2856.1146044725992, 3000.2799328161304, 3066.034199227259, 859.6561375449808, 895.901450840407, 909.9499527525984, 917.2753524715466, 919.7654598077514, 10941.398223097727, 10954.178436617285, 10978.560857565688, 10981.12151027916, 10999.670009899715, 3991.9201615967518, 4307.5477074906685, 4329.134173165379, 4404.66964977628, 4440.822367105279, 9297.349185557081, 9313.068693130634, 9317.906820931705, 9323.067693230623, 9325.114114159143, 4778.068276686083, 4803.063402636522, 4804.279358096243, 4811.663183577186, 4813.518648135158, 4095.3856921461424, 4370.519242883281, 4382.430284063052, 4383.320585309282, 4388.451443569554, 3357.932841343208, 3365.495175723612, 3468.583769947572, 3473.4095203815414, 3512.666296701809, 1050.6112738286884, 1054.8734151901667, 1059.86751656043, 1062.7608788022787, 1070.282910449985, 660.9306022867626, 709.2446544430165, 791.8495485857669, 819.2831272636444, 822.5106061893164, 5328.573714102862, 5417.674939503642, 5427.185922111636, 5503.394626591072, 5649.519790817826, 802.5465611929242, 851.7827953871723, 864.7492227254025, 877.4647465046316, 925.6898938855425, 3704.944425833615, 3709.7774133552075, 3752.6434988676033, 3757.774533527997, 3891.8832435026993, 9430.90569094314, 9622.855657165148, 9811.31320807551, 9967.40195588267, 9978.351407158512, 9867.950660246797, 9884.456354900549, 9897.158741507052, 9899.059589339002, 9899.109080182818, 7297.306755858185, 7380.077490313711, 7398.482106252511, 7415.703371865173, 7444.8883266751045, 5352.4915133062295, 5364.356277246756, 5409.134538473825, 5417.972910135424, 5556.0, 8847.292216622784, 8931.464112153291, 8946.463212207289, 8979.551022448983, 9056.864147037668, 8234.176582341717, 8581.184787445183, 8591.785205369915, 8831.823363532822, 9100.863487047567, 6581.111549940697, 6700.061991321317, 6719.832004199934, 6719.865602687821, 6762.053312536151, 7375.704971801068, 7452.06849143857, 7453.0, 7457.664405101892, 7459.738909138154, 6642.236142843635, 6799.830004249933, 6828.829279268058, 6870.3473170048765, 6985.0, 6673.632950187786, 6679.23188833271, 6722.2605513394465, 6775.356341147583, 6799.694013769491, 6233.844153896189, 6298.464630506458, 6337.746490140343, 6355.396237357444, 6359.872802544016, 4501.122281155274, 4688.140234457047, 4772.164871147605, 4782.2826576012485, 4864.343313652612, 4531.139083574242, 4564.360989461412, 4626.0, 4693.319468677091, 4734.26618874075], "value": 4143.895030868662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.8342244920396, 296.0983804315858, 303.6759727587717, 308.55722038874217, 308.58341239326927, 4704.670673052883, 4733.455652599952, 4737.715737055775, 4738.0, 4746.644001699873, 4651.7441540715245, 4656.789234798951, 4680.719156850591, 4681.391419115519, 4682.133805246031, 3744.9812750936208, 3749.568799588041, 3751.493548370976, 3751.6998640108727, 3757.210985693001, 3521.559805024372, 3765.8870233893026, 3772.4152756322815, 3772.717046221531, 3778.848846046155, 3697.5193224880863, 3749.9812500937455, 3757.8684746033896, 3764.3224219640456, 3770.2271034437877, 3738.308412943587, 3739.7943113128767, 3745.6628903398687, 3747.906302342436, 3748.6063963283736, 3156.794808337451, 3212.6947939945903, 3248.5127230915314, 3345.3476572068457, 3351.4470112431663, 4568.840090596813, 4569.543045695404, 4572.862814115582, 4574.4510658721165, 4603.434832157082, 4180.352045432963, 4232.513260974996, 4233.407322974786, 4233.767142807144, 4249.936250956238, 4593.44878614565, 4615.423072115986, 4860.1737704590305, 4871.512848715136, 4882.658213925027, 3574.410222313315, 3576.0, 3585.4621806728937, 3591.407417776064, 3593.5148754918014, 5089.567386772129, 5127.794888204505, 5136.332276804029, 5139.948600513984, 5140.7637677610355, 3606.7376418253402, 3701.4632878232505, 3714.4428335749312, 3715.5169827922196, 3722.2927643747603, 3746.3069332173636, 3763.435484677266, 3767.3595488766973, 3778.508793856781, 3782.0, 4218.240716671029, 4228.3234682451275, 4230.682698797603, 4230.957690423118, 4239.258129827268, 4910.361652985161, 4915.508449155056, 4918.9508104919205, 4921.188003979375, 4933.161362568372, 1249.900007999358, 1294.6664935116657, 1297.2411139483509, 1305.1386085183733, 1316.795896636023, 836.85773418519, 847.7541512961295, 862.978425539354, 863.2619110660421, 865.1391865094146, 3971.3645816669195, 3986.242613903349, 3992.7223288547966, 3993.4009898514873, 4011.799410029487, 4441.467023957081, 4451.933221001687, 4463.0, 4477.686561940698, 4502.774861256924, 3947.3289540778137, 3955.980220098881, 3966.643002129822, 3983.1876496194163, 3988.700847436454, 2295.4031951692346, 2324.651302304634, 2329.8895973875065, 2359.64605309205, 2390.8206884483734, 4256.5953235432235, 4615.676902616851, 4659.370984917061, 4720.442254056154, 4849.569377033784, 5194.168932970707, 5198.582659063553, 5205.29728486657, 5213.6089793265655, 5218.373795144607, 4774.466894498047, 4795.0, 4813.663043586916, 4822.180229360947, 4852.611791056707, 4938.851834444972, 4946.078985802945, 5039.622028347815, 5062.392512898328, 5072.28987941681, 4941.925871111865, 5018.272350509083, 5027.497250274943, 5034.597232221487, 5041.218611115283, 4846.539578740014, 4856.490068542894, 4856.8785780354365, 4857.975710121426, 4860.343853579721, 3609.9278014440088, 3696.5009723688036, 3713.220223752934, 3736.981315093407, 3763.5671897731017, 5072.82245121419, 5081.568066714222, 5084.161113416245, 5102.08162530748, 5127.0, 4886.951130488792, 4941.950580494149, 4946.1838796599595, 4951.5048495150195, 4953.356063711694, 4678.502879078798, 4905.313256144214, 4916.3362946001835, 4933.358663373739, 4938.30863679078, 4834.516548345137, 4851.2723091535145, 4851.975740121276, 4853.611711063177, 4862.3922009748785, 4945.826896058621, 4946.406431228275, 4949.737816856678, 4956.256561515657, 4964.946557866813, 4605.37827393311, 4847.636427267898, 4867.7322747249245, 4880.267959805916, 4891.559759621651], "value": 3699.759648343092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.7718160053181, 653.8528831013019, 667.2626747444074, 672.9495287853412, 691.671456058372, 12886.935565322172, 13446.663833404145, 13856.237906915128, 13899.166050037005, 13904.721905561883, 13345.733085338288, 13363.0, 13484.258365789901, 13541.119827211225, 13572.524961626345, 763.1071646173976, 783.3928705253417, 786.2530595933886, 786.5005721366945, 786.6735304848481, 614.4715544631613, 635.8156134720925, 743.31614914279, 785.3363907498183, 794.9006374203225, 816.6325153680838, 817.0154963269276, 817.995910020452, 818.4598165210962, 818.607068607069, 811.6063709101081, 811.930985866202, 812.1796985045117, 812.5937031484258, 812.6749300279877, 477.512936804461, 487.75124686409833, 489.75512243878063, 492.7634735327063, 492.95070492950776, 11739.119566032581, 12141.878581214252, 12305.507779688802, 12722.10945233834, 12791.48834046637, 13018.283994380305, 13835.584932452042, 13847.169169849842, 14094.718105637932, 14393.71212575753, 9788.427982233508, 9957.0540798624, 9995.500224988722, 10131.0, 10322.225833062475, 3332.350191712617, 3362.06939287433, 3387.9661203387896, 3445.0526105320987, 3513.2095278562374, 63838.0, 64805.67597161984, 67529.24653747914, 67538.66230668864, 67709.66145169243, 10523.21075919309, 10577.524011419504, 10602.575896964036, 10773.407462589475, 10794.78410431787, 20427.693584596243, 20547.38357849267, 20614.17543298281, 21084.47288817792, 21444.892775536024, 6881.311868813179, 6928.688209030605, 6929.792106236821, 7064.576125432491, 7104.822379440452, 3636.454531820248, 3650.7444478886755, 3661.176235347079, 3710.18375957289, 3712.9814350928614, 2866.426714657077, 2937.5593660951026, 2938.397628486155, 2960.259935016246, 2967.7774166937565, 479.0729937570812, 484.7309743092547, 493.6026498668534, 495.76946719775475, 503.1547001038291, 564.7430419159273, 572.8338781753245, 588.2000479348084, 589.8820235952741, 645.8643684826145, 8493.660253589787, 8539.0, 8636.481811091355, 8717.084706105768, 8900.643974241088, 589.0473081734038, 593.0274350065895, 598.628850112924, 600.9128676341905, 609.1989034419723, 3980.7611543306916, 3999.0, 4193.329067349209, 4197.853075142417, 4217.40956266123, 58980.0, 59072.40927590669, 74499.62750186323, 105467.0, 105521.0, 89101.0, 89761.0, 90269.99999999869, 90301.67888247891, 90602.54698726464, 76873.0, 77462.22537774662, 77966.0, 78115.60942195253, 80087.59956200299, 7850.528968261922, 7955.323797477279, 7976.441649084509, 7992.200779921961, 8143.714969976022, 45162.548374515834, 45613.77193114013, 45934.31098533458, 46400.30399543942, 46437.76781116208, 60922.0, 61399.0, 67515.649687005, 67539.66230168818, 68511.0, 10802.459877006275, 10840.403777791982, 10925.399103049409, 11006.559737610405, 11361.455417832933, 11325.0, 11577.412539551715, 11653.941730291293, 11911.225770324902, 12038.578649747216, 10546.0, 10578.365298082139, 10818.729531761768, 11268.267562608733, 11309.095272378025, 10727.624533141303, 10886.23796334249, 11054.723631909266, 11081.335119892832, 11121.666350009513, 9792.951035244778, 10080.395176289447, 10312.48437578133, 10669.46652667348, 10739.624113156002, 8413.242808147295, 8442.32461403074, 8773.298136148966, 8801.779955500908, 9157.175854173156, 8833.911660883567, 9211.501444892512, 9244.583993720433, 9326.347155699035, 9497.572609232462], "value": 6468.9405387630595, "unit": "score"}], "name": "dromaeo_css", "value": 6277.3254823082325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 115.0, 112.0, 112.0, 113.0, 114.0, 111.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 126.0, 170.0, 133.0, 126.0, 127.0, 127.0, 169.0, 143.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 112.0, 77.0, 77.0, 77.0, 76.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 85.0, 83.0, 82.0, 107.0, 84.0, 84.0, 115.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 64.0, 64.0, 66.0, 67.0, 67.0, 66.0, 68.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 88.0, 83.0, 83.0, 83.0, 94.0, 84.0, 82.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 159.0, 139.0, 148.0, 138.0, 136.0, 137.0, 145.0, 180.0, 141.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 174.0, 175.0, 184.0, 182.0, 183.0, 176.0, 173.0, 178.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 71.0, 72.0, 71.0, 70.0, 71.0, 71.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1558.7999999999997, "alertThreshold": 2.0}]} 14:32:05 INFO - Return code: 0 14:32:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:05 INFO - # TBPL SUCCESS # 14:32:05 INFO - Running post-action listener: _resource_record_post_action 14:32:05 INFO - [mozharness: 2016-10-13 21:32:05.337139Z] Finished run-tests step (success) 14:32:05 INFO - Running post-run listener: _resource_record_post_run 14:32:05 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409313280; Read time: 12; Write time: 266096 14:32:05 INFO - TinderboxPrint: CPU usage
13.1% 14:32:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:32:05 INFO - TinderboxPrint: I/O write bytes / time
409,313,280 / 266,096 14:32:05 INFO - TinderboxPrint: CPU idle
8,351.5 (86.9%) 14:32:05 INFO - TinderboxPrint: CPU user
1,205.3 (12.5%) 14:32:05 INFO - TinderboxPrint: Swap in / out
0 / 0 14:32:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115539968; Read time: 0; Write time: 73300 14:32:05 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292724736; Read time: 0; Write time: 192776 14:32:05 INFO - Running post-run listener: _upload_blobber_files 14:32:05 INFO - Blob upload gear active. 14:32:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:09 INFO - (blobuploader) - INFO - Done attempting. 14:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:10 INFO - (blobuploader) - INFO - Done attempting. 14:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:11 INFO - (blobuploader) - INFO - Done attempting. 14:32:11 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:11 INFO - Return code: 0 14:32:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d10637518c9c471976e14ccae6832e3cf2c5c647ecd6d3bb30e2b646890833cb32c80721d19b0b7f5286898a4202ab7b091c104dfb70848379828b2fb8aa410d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b3efdb597fe68f4a31f50ed61a84004eac2c55f822281fbc91d7f9102823fa118ba277f71960d69984b3e1607d25e26ae652db3baf37300276d15b9bac51e4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa6f46a09424959580b175138ef8ee28154ffe88359ea7f49590b65d43f59f429eee43a439cc514d12764490f88f2fdc3e16bf2d91c58b5f7b0b596172adbae"} 14:32:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:11 INFO - Contents: 14:32:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d10637518c9c471976e14ccae6832e3cf2c5c647ecd6d3bb30e2b646890833cb32c80721d19b0b7f5286898a4202ab7b091c104dfb70848379828b2fb8aa410d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b3efdb597fe68f4a31f50ed61a84004eac2c55f822281fbc91d7f9102823fa118ba277f71960d69984b3e1607d25e26ae652db3baf37300276d15b9bac51e4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa6f46a09424959580b175138ef8ee28154ffe88359ea7f49590b65d43f59f429eee43a439cc514d12764490f88f2fdc3e16bf2d91c58b5f7b0b596172adbae"} 14:32:11 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:11 INFO - Copying logs to upload dir... 14:32:11 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.384250 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-13 14:32:10.892174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:32:10.896609) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d10637518c9c471976e14ccae6832e3cf2c5c647ecd6d3bb30e2b646890833cb32c80721d19b0b7f5286898a4202ab7b091c104dfb70848379828b2fb8aa410d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b3efdb597fe68f4a31f50ed61a84004eac2c55f822281fbc91d7f9102823fa118ba277f71960d69984b3e1607d25e26ae652db3baf37300276d15b9bac51e4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa6f46a09424959580b175138ef8ee28154ffe88359ea7f49590b65d43f59f429eee43a439cc514d12764490f88f2fdc3e16bf2d91c58b5f7b0b596172adbae"} build_url:https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/Jij8R6LHSPim1YB3sdpYmA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d10637518c9c471976e14ccae6832e3cf2c5c647ecd6d3bb30e2b646890833cb32c80721d19b0b7f5286898a4202ab7b091c104dfb70848379828b2fb8aa410d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b3efdb597fe68f4a31f50ed61a84004eac2c55f822281fbc91d7f9102823fa118ba277f71960d69984b3e1607d25e26ae652db3baf37300276d15b9bac51e4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa6f46a09424959580b175138ef8ee28154ffe88359ea7f49590b65d43f59f429eee43a439cc514d12764490f88f2fdc3e16bf2d91c58b5f7b0b596172adbae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:32:10.924587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:32:10.924905) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1476393081.438165-772574085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:32:11.007928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:32:11.011299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:32:11.011620) ========= ========= Total master_lag: 0.18 =========