builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1475814704.47 results: success (0) buildid: 20161006200200 builduid: b5134789ee95406cbd6dc7090c5b4f56 revision: e4333cfe24b97169233450f9010474464eeaff85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.471395) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.472158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.472479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.488750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.489072) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:31:44-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-10-06 21:31:45 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143093 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.842003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.842332) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018675 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.882667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:44.883023) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e4333cfe24b97169233450f9010474464eeaff85 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e4333cfe24b97169233450f9010474464eeaff85 --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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:31:45,419 truncating revision to first 12 chars 2016-10-06 21:31:45,420 Setting DEBUG logging. 2016-10-06 21:31:45,420 attempt 1/10 2016-10-06 21:31:45,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e4333cfe24b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:31:45,924 unpacking tar archive at: autoland-e4333cfe24b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:45.715979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:45.716679) ========= script_repo_revision: e4333cfe24b97169233450f9010474464eeaff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:45.717720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:45.718265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:31:45.730449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-06 21:31:45.730773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:31:46 INFO - MultiFileLogger online at 20161006 21:31:46 in /builds/slave/test 21:31:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 21:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:31:46 INFO - {'append_to_log': False, 21:31:46 INFO - 'base_work_dir': '/builds/slave/test', 21:31:46 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:31:46 INFO - 'branch': 'Autoland-Non-PGO', 21:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 21:31:46 INFO - 'config_files': ('talos/linux_config.py',), 21:31:46 INFO - 'default_actions': ('clobber', 21:31:46 INFO - 'read-buildbot-config', 21:31:46 INFO - 'download-and-extract', 21:31:46 INFO - 'populate-webroot', 21:31:46 INFO - 'create-virtualenv', 21:31:46 INFO - 'install', 21:31:46 INFO - 'run-tests'), 21:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:31:46 INFO - 'download_minidump_stackwalk': True, 21:31:46 INFO - 'download_symbols': 'ondemand', 21:31:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:31:46 INFO - 'tooltool.py': '/tools/tooltool.py', 21:31:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:31:46 INFO - '/tools/misc-python/virtualenv.py')}, 21:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:31:46 INFO - 'installer_path': 'installer.exe', 21:31:46 INFO - 'log_level': 'info', 21:31:46 INFO - 'log_name': 'talos', 21:31:46 INFO - 'log_to_console': True, 21:31:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:31:46 INFO - 'opt_config_files': (), 21:31:46 INFO - 'pip_index': False, 21:31:46 INFO - 'sps_profile': False, 21:31:46 INFO - 'sps_profile_interval': 0, 21:31:46 INFO - 'suite': 'dromaeojs', 21:31:46 INFO - 'system_bits': '32', 21:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:31:46 INFO - 'title': 'talos-linux64-ix-006', 21:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:31:46 INFO - 'use_talos_json': True, 21:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:31:46 INFO - 'work_dir': 'build'} 21:31:46 INFO - [mozharness: 2016-10-07 04:31:46.373588Z] Running clobber step. 21:31:46 INFO - Running pre-action listener: _resource_record_pre_action 21:31:46 INFO - Running main action method: clobber 21:31:46 INFO - rmtree: /builds/slave/test/build 21:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:31:47 INFO - Running post-action listener: _resource_record_post_action 21:31:47 INFO - [mozharness: 2016-10-07 04:31:47.343112Z] Finished clobber step (success) 21:31:47 INFO - [mozharness: 2016-10-07 04:31:47.343213Z] Running read-buildbot-config step. 21:31:47 INFO - Running pre-action listener: _resource_record_pre_action 21:31:47 INFO - Running main action method: read_buildbot_config 21:31:47 INFO - Using buildbot properties: 21:31:47 INFO - { 21:31:47 INFO - "project": "", 21:31:47 INFO - "product": "firefox", 21:31:47 INFO - "script_repo_revision": "production", 21:31:47 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:31:47 INFO - "repository": "", 21:31:47 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 21:31:47 INFO - "buildid": "20161006200200", 21:31:47 INFO - "pgo_build": "False", 21:31:47 INFO - "basedir": "/builds/slave/test", 21:31:47 INFO - "buildnumber": 713, 21:31:47 INFO - "slavename": "talos-linux64-ix-006", 21:31:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:31:47 INFO - "platform": "ubuntu64_hw", 21:31:47 INFO - "scheduler": "tests-autoland-linux64-talos", 21:31:47 INFO - "branch": "autoland", 21:31:47 INFO - "repo_path": "integration/autoland", 21:31:47 INFO - "revision": "e4333cfe24b97169233450f9010474464eeaff85", 21:31:47 INFO - "stage_platform": "linux64", 21:31:47 INFO - "builduid": "b5134789ee95406cbd6dc7090c5b4f56", 21:31:47 INFO - "slavebuilddir": "test" 21:31:47 INFO - } 21:31:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:31:47 INFO - Running post-action listener: _resource_record_post_action 21:31:47 INFO - [mozharness: 2016-10-07 04:31:47.345656Z] Finished read-buildbot-config step (success) 21:31:47 INFO - [mozharness: 2016-10-07 04:31:47.345744Z] Running download-and-extract step. 21:31:47 INFO - Running pre-action listener: _resource_record_pre_action 21:31:47 INFO - Running main action method: download_and_extract 21:31:47 INFO - mkdir: /builds/slave/test/build/tests 21:31: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')]} 21:31:47 INFO - trying https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:31:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/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 21:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/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 21:31:48 INFO - Downloaded 1361 bytes. 21:31:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:31:48 INFO - Using the following test package requirements: 21:31:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:31:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:31:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'jsshell-linux-x86_64.zip'], 21:31:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:31:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:31:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:31:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:31:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:31:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:31:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:31:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:31:48 INFO - Http code: 200 21:31:48 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:31:48 INFO - x-amz-cf-id: 3eY4leteEh_GUT11pLP7uN1cC36e4_CSym_IZwE11n6XIsHwdKqtww== 21:31:48 INFO - x-amz-version-id: vqzLxUZcTNovCNzKcSoaJRLVkUeeqOka 21:31:49 INFO - Expected file size: 20445984 21:31:49 INFO - Obtained file size: 20445984 21:31:53 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 21:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:31:53 INFO - Http code: 200 21:31:53 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 21:31:53 INFO - x-amz-cf-id: 1mvUA0UBPhGD7ClKDwE72TKD6R5HUh_qh7I9aa53Wk1GPqqh17UYSA== 21:31:53 INFO - x-amz-version-id: vqzLxUZcTNovCNzKcSoaJRLVkUeeqOka 21:31:54 INFO - Expected file size: 20445984 21:31:54 INFO - Obtained file size: 20445984 21:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:31:59 INFO - Http code: 200 21:31:59 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:31:59 INFO - x-amz-cf-id: xHNM6zRa6PQROWwlGjuRQh57c7JHrbhR6P7Yz3FmCafX3OgKdcw77w== 21:31:59 INFO - x-amz-version-id: MU1MQskc3IE1ROeQbWWlmbaCfdEDRaAS 21:32:00 INFO - Expected file size: 14409006 21:32:00 INFO - Obtained file size: 14409006 21:32: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')]} 21:32:00 INFO - trying https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:32:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/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 21:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/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 21:32:02 INFO - Downloaded 55826629 bytes. 21:32:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:32:02 INFO - mkdir: /builds/slave/test/properties 21:32:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:32:02 INFO - Writing to file /builds/slave/test/properties/build_url 21:32:02 INFO - Contents: 21:32:02 INFO - build_url:https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:32:03 INFO - Running post-action listener: _resource_record_post_action 21:32:03 INFO - Running post-action listener: set_extra_try_arguments 21:32:03 INFO - [mozharness: 2016-10-07 04:32:03.446243Z] Finished download-and-extract step (success) 21:32:03 INFO - [mozharness: 2016-10-07 04:32:03.446470Z] Running populate-webroot step. 21:32:03 INFO - Running pre-action listener: _resource_record_pre_action 21:32:03 INFO - Running main action method: populate_webroot 21:32:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:32:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:32:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:32:03 INFO - '--tppagecycles', 21:32:03 INFO - '7'], 21:32:03 INFO - 'tests': ['tsvgm']}}, 21:32:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:32:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:32:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:32:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:32:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['damp', 'tps']}, 21:32:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'tests': ['damp', 'tps']}, 21:32:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['dromaeo_dom']}, 21:32:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:32:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['basic_compositor_video']}, 21:32:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:32:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['a11yr', 21:32:03 INFO - 'ts_paint', 21:32:03 INFO - 'tpaint', 21:32:03 INFO - 'sessionrestore', 21:32:03 INFO - 'sessionrestore_no_auto_restore', 21:32:03 INFO - 'tabpaint']}, 21:32:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['tsvgx', 21:32:03 INFO - 'tsvgr_opacity', 21:32:03 INFO - 'tart', 21:32:03 INFO - 'tscrollx', 21:32:03 INFO - 'cart']}, 21:32:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:32:03 INFO - 'tsvgr_opacity', 21:32:03 INFO - 'tart', 21:32:03 INFO - 'tscrollx', 21:32:03 INFO - 'cart']}, 21:32:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'talos_options': ['--disable-e10s'], 21:32:03 INFO - 'tests': ['tp5o']}, 21:32:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'tests': ['tp5o']}, 21:32:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'talos_options': ['--disable-e10s', 21:32:03 INFO - '--xperf_path', 21:32:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:03 INFO - 'tests': ['tp5n']}, 21:32:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:03 INFO - 'talos_options': ['--xperf_path', 21:32:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:03 INFO - 'tests': ['tp5n']}}, 21:32:03 INFO - 'talos.zip': {'path': '', 21:32:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:32:03 INFO - Running post-action listener: _resource_record_post_action 21:32:03 INFO - [mozharness: 2016-10-07 04:32:03.473128Z] Finished populate-webroot step (success) 21:32:03 INFO - [mozharness: 2016-10-07 04:32:03.473217Z] Running create-virtualenv step. 21:32:03 INFO - Running pre-action listener: _resource_record_pre_action 21:32:03 INFO - Running main action method: create_virtualenv 21:32:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:32:03 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 21:32:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:32:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:32:03 INFO - Using real prefix '/usr' 21:32:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:32:04 INFO - Installing distribute.............................................................................................................................................................................................done. 21:32:06 INFO - Installing pip.................done. 21:32:06 INFO - Return code: 0 21:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:32:06 INFO - Reading from file tmpfile_stdout 21:32:06 INFO - Output received: 21:32:06 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) 21:32:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:32:06 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')]} 21:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:06 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')]} 21:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:06 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:06 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 21:32:06 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 21:32:06 INFO - Using env: {'DISPLAY': ':0', 21:32:06 INFO - 'HOME': '/home/cltbld', 21:32:06 INFO - 'LANG': 'en_US.UTF-8', 21:32:06 INFO - 'LANGUAGE': 'en_US:en', 21:32:06 INFO - 'LOGNAME': 'cltbld', 21:32:06 INFO - 'MAIL': '/var/mail/cltbld', 21:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:06 INFO - 'MOZ_NO_REMOTE': '1', 21:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:06 INFO - 'NO_EM_RESTART': '1', 21:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:06 INFO - 'PWD': '/builds/slave/test', 21:32:06 INFO - 'SHELL': '/bin/bash', 21:32:06 INFO - 'SHLVL': '1', 21:32:06 INFO - 'TERM': 'linux', 21:32:06 INFO - 'TMOUT': '86400', 21:32:06 INFO - 'USER': 'cltbld', 21:32:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:06 INFO - '_': '/tools/buildbot/bin/python'} 21:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:06 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 21:32:06 INFO - Cleaning up... 21:32:06 INFO - Return code: 0 21:32:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:32:06 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')]} 21:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:06 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')]} 21:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:06 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:06 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 21:32:06 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 21:32:06 INFO - Using env: {'DISPLAY': ':0', 21:32:06 INFO - 'HOME': '/home/cltbld', 21:32:06 INFO - 'LANG': 'en_US.UTF-8', 21:32:06 INFO - 'LANGUAGE': 'en_US:en', 21:32:06 INFO - 'LOGNAME': 'cltbld', 21:32:06 INFO - 'MAIL': '/var/mail/cltbld', 21:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:06 INFO - 'MOZ_NO_REMOTE': '1', 21:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:06 INFO - 'NO_EM_RESTART': '1', 21:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:06 INFO - 'PWD': '/builds/slave/test', 21:32:06 INFO - 'SHELL': '/bin/bash', 21:32:06 INFO - 'SHLVL': '1', 21:32:06 INFO - 'TERM': 'linux', 21:32:06 INFO - 'TMOUT': '86400', 21:32:06 INFO - 'USER': 'cltbld', 21:32:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:06 INFO - '_': '/tools/buildbot/bin/python'} 21:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:06 INFO - Downloading/unpacking psutil>=3.1.1 21:32:06 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 21:32:06 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 21:32:06 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 21:32:06 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 21:32:06 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 21:32:06 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 21:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:08 INFO - Installing collected packages: psutil 21:32:08 INFO - Running setup.py install for psutil 21:32:08 INFO - building 'psutil._psutil_linux' extension 21:32:08 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 21:32:08 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 21:32:08 INFO - building 'psutil._psutil_posix' extension 21:32:08 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 21:32:09 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 21:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:09 INFO - Successfully installed psutil 21:32:09 INFO - Cleaning up... 21:32:09 INFO - Return code: 0 21:32:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:32:09 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')]} 21:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:09 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')]} 21:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:09 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:09 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 21:32:09 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 21:32:09 INFO - Using env: {'DISPLAY': ':0', 21:32:09 INFO - 'HOME': '/home/cltbld', 21:32:09 INFO - 'LANG': 'en_US.UTF-8', 21:32:09 INFO - 'LANGUAGE': 'en_US:en', 21:32:09 INFO - 'LOGNAME': 'cltbld', 21:32:09 INFO - 'MAIL': '/var/mail/cltbld', 21:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:09 INFO - 'MOZ_NO_REMOTE': '1', 21:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:09 INFO - 'NO_EM_RESTART': '1', 21:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:09 INFO - 'PWD': '/builds/slave/test', 21:32:09 INFO - 'SHELL': '/bin/bash', 21:32:09 INFO - 'SHLVL': '1', 21:32:09 INFO - 'TERM': 'linux', 21:32:09 INFO - 'TMOUT': '86400', 21:32:09 INFO - 'USER': 'cltbld', 21:32:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:09 INFO - '_': '/tools/buildbot/bin/python'} 21:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:32:09 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 21:32:09 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 21:32:09 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 21:32:09 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 21:32:09 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 21:32:09 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 21:32:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:32:11 INFO - Installing collected packages: mozsystemmonitor 21:32:11 INFO - Running setup.py install for mozsystemmonitor 21:32:11 INFO - Successfully installed mozsystemmonitor 21:32:11 INFO - Cleaning up... 21:32:11 INFO - Return code: 0 21:32:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:32:11 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')]} 21:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:11 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')]} 21:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:11 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:11 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 21:32:11 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 21:32:11 INFO - Using env: {'DISPLAY': ':0', 21:32:11 INFO - 'HOME': '/home/cltbld', 21:32:11 INFO - 'LANG': 'en_US.UTF-8', 21:32:11 INFO - 'LANGUAGE': 'en_US:en', 21:32:11 INFO - 'LOGNAME': 'cltbld', 21:32:11 INFO - 'MAIL': '/var/mail/cltbld', 21:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:11 INFO - 'MOZ_NO_REMOTE': '1', 21:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:11 INFO - 'NO_EM_RESTART': '1', 21:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:11 INFO - 'PWD': '/builds/slave/test', 21:32:11 INFO - 'SHELL': '/bin/bash', 21:32:11 INFO - 'SHLVL': '1', 21:32:11 INFO - 'TERM': 'linux', 21:32:11 INFO - 'TMOUT': '86400', 21:32:11 INFO - 'USER': 'cltbld', 21:32:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:11 INFO - '_': '/tools/buildbot/bin/python'} 21:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:11 INFO - Downloading/unpacking jsonschema==2.5.1 21:32:11 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 21:32:11 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 21:32:11 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 21:32:11 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 21:32:11 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 21:32:11 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 21:32:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:32:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:32:13 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 21:32:13 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 21:32:13 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 21:32:13 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 21:32:13 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 21:32:13 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 21:32:13 INFO - Downloading functools32-3.2.3-2.tar.gz 21:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:32:13 INFO - warning: no files found matching '*.txt' 21:32:13 INFO - no previously-included directories found matching 'build' 21:32:13 INFO - no previously-included directories found matching 'dist' 21:32:13 INFO - no previously-included directories found matching '.git*' 21:32:13 INFO - Installing collected packages: jsonschema, functools32 21:32:14 INFO - Running setup.py install for functools32 21:32:14 INFO - warning: no files found matching '*.txt' 21:32:14 INFO - no previously-included directories found matching 'build' 21:32:14 INFO - no previously-included directories found matching 'dist' 21:32:14 INFO - no previously-included directories found matching '.git*' 21:32:14 INFO - Successfully installed jsonschema functools32 21:32:14 INFO - Cleaning up... 21:32:14 INFO - Return code: 0 21:32:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:32:14 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')]} 21:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:14 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')]} 21:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:14 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:14 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 21:32:14 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 21:32:14 INFO - Using env: {'DISPLAY': ':0', 21:32:14 INFO - 'HOME': '/home/cltbld', 21:32:14 INFO - 'LANG': 'en_US.UTF-8', 21:32:14 INFO - 'LANGUAGE': 'en_US:en', 21:32:14 INFO - 'LOGNAME': 'cltbld', 21:32:14 INFO - 'MAIL': '/var/mail/cltbld', 21:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:14 INFO - 'MOZ_NO_REMOTE': '1', 21:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:14 INFO - 'NO_EM_RESTART': '1', 21:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:14 INFO - 'PWD': '/builds/slave/test', 21:32:14 INFO - 'SHELL': '/bin/bash', 21:32:14 INFO - 'SHLVL': '1', 21:32:14 INFO - 'TERM': 'linux', 21:32:14 INFO - 'TMOUT': '86400', 21:32:14 INFO - 'USER': 'cltbld', 21:32:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:14 INFO - '_': '/tools/buildbot/bin/python'} 21:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:32:14 INFO - Cleaning up... 21:32:14 INFO - Return code: 0 21:32:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:32:14 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')]} 21:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:14 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')]} 21:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:14 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:14 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 21:32:14 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 21:32:14 INFO - Using env: {'DISPLAY': ':0', 21:32:14 INFO - 'HOME': '/home/cltbld', 21:32:14 INFO - 'LANG': 'en_US.UTF-8', 21:32:14 INFO - 'LANGUAGE': 'en_US:en', 21:32:14 INFO - 'LOGNAME': 'cltbld', 21:32:14 INFO - 'MAIL': '/var/mail/cltbld', 21:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:14 INFO - 'MOZ_NO_REMOTE': '1', 21:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:14 INFO - 'NO_EM_RESTART': '1', 21:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:14 INFO - 'PWD': '/builds/slave/test', 21:32:14 INFO - 'SHELL': '/bin/bash', 21:32:14 INFO - 'SHLVL': '1', 21:32:14 INFO - 'TERM': 'linux', 21:32:14 INFO - 'TMOUT': '86400', 21:32:14 INFO - 'USER': 'cltbld', 21:32:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:14 INFO - '_': '/tools/buildbot/bin/python'} 21:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:14 INFO - Downloading/unpacking blobuploader==1.2.4 21:32:14 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 21:32:14 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 21:32:14 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 21:32:14 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 21:32:14 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 21:32:14 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 21:32:16 INFO - Downloading blobuploader-1.2.4.tar.gz 21:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:32:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:32:16 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 21:32:16 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 21:32:16 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 21:32:16 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 21:32:16 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 21:32:16 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 21:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:32:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:32:17 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 21:32:17 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 21:32:17 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 21:32:17 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 21:32:17 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 21:32:17 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 21:32:17 INFO - Downloading docopt-0.6.1.tar.gz 21:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:32:17 INFO - Installing collected packages: blobuploader, requests, docopt 21:32:17 INFO - Running setup.py install for blobuploader 21:32:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:32:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:32:17 INFO - Running setup.py install for requests 21:32:17 INFO - Running setup.py install for docopt 21:32:18 INFO - Successfully installed blobuploader requests docopt 21:32:18 INFO - Cleaning up... 21:32:18 INFO - Return code: 0 21:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:18 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')]} 21:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:18 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')]} 21:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:18 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:18 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 21:32:18 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 21:32:18 INFO - Using env: {'DISPLAY': ':0', 21:32:18 INFO - 'HOME': '/home/cltbld', 21:32:18 INFO - 'LANG': 'en_US.UTF-8', 21:32:18 INFO - 'LANGUAGE': 'en_US:en', 21:32:18 INFO - 'LOGNAME': 'cltbld', 21:32:18 INFO - 'MAIL': '/var/mail/cltbld', 21:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:18 INFO - 'MOZ_NO_REMOTE': '1', 21:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:18 INFO - 'NO_EM_RESTART': '1', 21:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:18 INFO - 'PWD': '/builds/slave/test', 21:32:18 INFO - 'SHELL': '/bin/bash', 21:32:18 INFO - 'SHLVL': '1', 21:32:18 INFO - 'TERM': 'linux', 21:32:18 INFO - 'TMOUT': '86400', 21:32:18 INFO - 'USER': 'cltbld', 21:32:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:18 INFO - '_': '/tools/buildbot/bin/python'} 21:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:32:18 INFO - Running setup.py (path:/tmp/pip-Ph08B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:32:18 INFO - Running setup.py (path:/tmp/pip-Y61fiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:32:18 INFO - Running setup.py (path:/tmp/pip-Gv7m9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:32:18 INFO - Running setup.py (path:/tmp/pip-Ayxqn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:32:18 INFO - Running setup.py (path:/tmp/pip-g957zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:32:18 INFO - Running setup.py (path:/tmp/pip-A4DeaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:32:18 INFO - Running setup.py (path:/tmp/pip-ygueMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:32:18 INFO - Running setup.py (path:/tmp/pip-jZwGl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:32:18 INFO - Running setup.py (path:/tmp/pip-bIh4JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:32:18 INFO - Running setup.py (path:/tmp/pip-Maj2JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:32:19 INFO - Running setup.py (path:/tmp/pip-f5kQG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:32:19 INFO - Running setup.py (path:/tmp/pip-QPKfnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:32:19 INFO - Running setup.py (path:/tmp/pip-WVWkZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:32:19 INFO - Running setup.py (path:/tmp/pip-CnwAcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:19 INFO - Running setup.py (path:/tmp/pip-lR9MlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:32:19 INFO - Running setup.py (path:/tmp/pip-mtwt0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:32:19 INFO - Running setup.py (path:/tmp/pip-Reh8nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:32:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:32:19 INFO - Running setup.py install for manifestparser 21:32:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:32:19 INFO - Running setup.py install for mozcrash 21:32:19 INFO - Running setup.py install for mozdebug 21:32:19 INFO - Running setup.py install for mozdevice 21:32:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:32:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:32:19 INFO - Running setup.py install for mozfile 21:32:20 INFO - Running setup.py install for mozhttpd 21:32:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for mozinfo 21:32:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for mozInstall 21:32:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for mozleak 21:32:20 INFO - Running setup.py install for mozlog 21:32:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for moznetwork 21:32:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for mozprocess 21:32:20 INFO - Running setup.py install for mozprofile 21:32:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:32:20 INFO - Running setup.py install for mozrunner 21:32:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:32:21 INFO - Running setup.py install for mozscreenshot 21:32:21 INFO - Running setup.py install for moztest 21:32:21 INFO - Running setup.py install for mozversion 21:32:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:32:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:32:21 INFO - Cleaning up... 21:32:21 INFO - Return code: 0 21:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:21 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')]} 21:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:21 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')]} 21:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:21 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:21 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 21:32:21 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 21:32:21 INFO - Using env: {'DISPLAY': ':0', 21:32:21 INFO - 'HOME': '/home/cltbld', 21:32:21 INFO - 'LANG': 'en_US.UTF-8', 21:32:21 INFO - 'LANGUAGE': 'en_US:en', 21:32:21 INFO - 'LOGNAME': 'cltbld', 21:32:21 INFO - 'MAIL': '/var/mail/cltbld', 21:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:21 INFO - 'MOZ_NO_REMOTE': '1', 21:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:21 INFO - 'NO_EM_RESTART': '1', 21:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:21 INFO - 'PWD': '/builds/slave/test', 21:32:21 INFO - 'SHELL': '/bin/bash', 21:32:21 INFO - 'SHLVL': '1', 21:32:21 INFO - 'TERM': 'linux', 21:32:21 INFO - 'TMOUT': '86400', 21:32:21 INFO - 'USER': 'cltbld', 21:32:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:21 INFO - '_': '/tools/buildbot/bin/python'} 21:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:32:21 INFO - Running setup.py (path:/tmp/pip-9wOm3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:32:21 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)) 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:32:21 INFO - Running setup.py (path:/tmp/pip-cgH_1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:32:21 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)) 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:32:21 INFO - Running setup.py (path:/tmp/pip-6ufdho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:32:21 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)) 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:32:21 INFO - Running setup.py (path:/tmp/pip-LnejiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:32:21 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)) 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:32:21 INFO - Running setup.py (path:/tmp/pip-9_mczh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:32:21 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)) 21:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:32:21 INFO - Running setup.py (path:/tmp/pip-FrHDPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:32:22 INFO - Running setup.py (path:/tmp/pip-GiiMjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:32:22 INFO - Running setup.py (path:/tmp/pip-1n4GSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:32:22 INFO - Running setup.py (path:/tmp/pip-msc6BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:32:22 INFO - Running setup.py (path:/tmp/pip-PuyMJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:32:22 INFO - Running setup.py (path:/tmp/pip-O6yHzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:32:22 INFO - Running setup.py (path:/tmp/pip-2vVV5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:32:22 INFO - Running setup.py (path:/tmp/pip-bxGFoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:32:22 INFO - Running setup.py (path:/tmp/pip-KrNNUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:22 INFO - Running setup.py (path:/tmp/pip-vGFp0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:32:22 INFO - Running setup.py (path:/tmp/pip-7Pe5NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:32:22 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)) 21:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:32:22 INFO - Running setup.py (path:/tmp/pip-SUpFAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:32:22 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)) 21:32:22 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)) 21:32:22 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)) 21:32:22 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)) 21:32:22 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)) 21:32:22 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)) 21:32:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:32:22 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 21:32:22 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 21:32:22 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 21:32:22 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 21:32:22 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 21:32:22 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 21:32:24 INFO - Downloading blessings-1.6.tar.gz 21:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:32:24 INFO - Installing collected packages: blessings 21:32:24 INFO - Running setup.py install for blessings 21:32:24 INFO - Successfully installed blessings 21:32:24 INFO - Cleaning up... 21:32:24 INFO - Return code: 0 21:32:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:32:25 INFO - Reading from file tmpfile_stdout 21:32:25 INFO - Current package versions: 21:32:25 INFO - argparse == 1.2.1 21:32:25 INFO - blessings == 1.6 21:32:25 INFO - blobuploader == 1.2.4 21:32:25 INFO - docopt == 0.6.1 21:32:25 INFO - functools32 == 3.2.3-2 21:32:25 INFO - jsonschema == 2.5.1 21:32:25 INFO - manifestparser == 1.1 21:32:25 INFO - mozInstall == 1.12 21:32:25 INFO - mozcrash == 0.17 21:32:25 INFO - mozdebug == 0.1 21:32:25 INFO - mozdevice == 0.48 21:32:25 INFO - mozfile == 1.2 21:32:25 INFO - mozhttpd == 0.7 21:32:25 INFO - mozinfo == 0.9 21:32:25 INFO - mozleak == 0.1 21:32:25 INFO - mozlog == 3.4 21:32:25 INFO - moznetwork == 0.27 21:32:25 INFO - mozprocess == 0.23 21:32:25 INFO - mozprofile == 0.28 21:32:25 INFO - mozrunner == 6.12 21:32:25 INFO - mozscreenshot == 0.1 21:32:25 INFO - mozsystemmonitor == 0.3 21:32:25 INFO - moztest == 0.7 21:32:25 INFO - mozversion == 1.4 21:32:25 INFO - psutil == 3.1.1 21:32:25 INFO - requests == 1.2.3 21:32:25 INFO - wsgiref == 0.1.2 21:32:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:25 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')]} 21:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 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')]} 21:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:25 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 21:32:25 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 21:32:25 INFO - Using env: {'DISPLAY': ':0', 21:32:25 INFO - 'HOME': '/home/cltbld', 21:32:25 INFO - 'LANG': 'en_US.UTF-8', 21:32:25 INFO - 'LANGUAGE': 'en_US:en', 21:32:25 INFO - 'LOGNAME': 'cltbld', 21:32:25 INFO - 'MAIL': '/var/mail/cltbld', 21:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:25 INFO - 'MOZ_NO_REMOTE': '1', 21:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:25 INFO - 'NO_EM_RESTART': '1', 21:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:25 INFO - 'PWD': '/builds/slave/test', 21:32:25 INFO - 'SHELL': '/bin/bash', 21:32:25 INFO - 'SHLVL': '1', 21:32:25 INFO - 'TERM': 'linux', 21:32:25 INFO - 'TMOUT': '86400', 21:32:25 INFO - 'USER': 'cltbld', 21:32:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:25 INFO - '_': '/tools/buildbot/bin/python'} 21:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 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)) 21:32:25 INFO - Cleaning up... 21:32:25 INFO - Return code: 0 21:32:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:32:25 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')]} 21:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 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')]} 21:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 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 0x7f47d0ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf67ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', '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 21:32:25 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 21:32:25 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 21:32:25 INFO - Using env: {'DISPLAY': ':0', 21:32:25 INFO - 'HOME': '/home/cltbld', 21:32:25 INFO - 'LANG': 'en_US.UTF-8', 21:32:25 INFO - 'LANGUAGE': 'en_US:en', 21:32:25 INFO - 'LOGNAME': 'cltbld', 21:32:25 INFO - 'MAIL': '/var/mail/cltbld', 21:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:25 INFO - 'MOZ_NO_REMOTE': '1', 21:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:25 INFO - 'NO_EM_RESTART': '1', 21:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:25 INFO - 'PWD': '/builds/slave/test', 21:32:25 INFO - 'SHELL': '/bin/bash', 21:32:25 INFO - 'SHLVL': '1', 21:32:25 INFO - 'TERM': 'linux', 21:32:25 INFO - 'TMOUT': '86400', 21:32:25 INFO - 'USER': 'cltbld', 21:32:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:25 INFO - '_': '/tools/buildbot/bin/python'} 21:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:32:25 INFO - Cleaning up... 21:32:25 INFO - Return code: 0 21:32:25 INFO - Running post-action listener: _resource_record_post_action 21:32:25 INFO - Running post-action listener: _start_resource_monitoring 21:32:25 INFO - Starting resource monitoring. 21:32:25 INFO - [mozharness: 2016-10-07 04:32:25.673121Z] Finished create-virtualenv step (success) 21:32:25 INFO - [mozharness: 2016-10-07 04:32:25.673634Z] Running install step. 21:32:25 INFO - Running pre-action listener: _resource_record_pre_action 21:32:25 INFO - Running main action method: install 21:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:32:25 INFO - Reading from file tmpfile_stdout 21:32:25 INFO - Detecting whether we're running mozinstall >=1.0... 21:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:32:25 INFO - Reading from file tmpfile_stdout 21:32:25 INFO - Output received: 21:32:25 INFO - Usage: mozinstall [options] installer 21:32:25 INFO - Options: 21:32:25 INFO - -h, --help show this help message and exit 21:32:25 INFO - -d DEST, --destination=DEST 21:32:25 INFO - Directory to install application into. [default: 21:32:25 INFO - "/builds/slave/test"] 21:32:25 INFO - --app=APP Application being installed. [default: firefox] 21:32:25 INFO - mkdir: /builds/slave/test/build/application 21:32:25 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'] 21:32:25 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 21:32:42 INFO - Reading from file tmpfile_stdout 21:32:42 INFO - Output received: 21:32:42 INFO - /builds/slave/test/build/application/firefox/firefox 21:32:42 INFO - Running post-action listener: _resource_record_post_action 21:32:42 INFO - [mozharness: 2016-10-07 04:32:42.123061Z] Finished install step (success) 21:32:42 INFO - [mozharness: 2016-10-07 04:32:42.123306Z] Running run-tests step. 21:32:42 INFO - Running pre-action listener: _resource_record_pre_action 21:32:42 INFO - Running main action method: run_tests 21:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:32:42 INFO - Python 2.7.3 21:32:42 INFO - Return code: 0 21:32:42 INFO - grabbing minidump binary from tooltool 21:32:42 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')]} 21:32:42 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 0xf64f60>, '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 0xf65d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf661d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:32:42 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 21:32:42 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 21:32:42 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 21:32:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:32:42 INFO - Return code: 0 21:32:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:32:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:32:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:32:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:32:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 21:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 21:32:42 INFO - Using env: {'DISPLAY': ':0', 21:32:42 INFO - 'HOME': '/home/cltbld', 21:32:42 INFO - 'LANG': 'en_US.UTF-8', 21:32:42 INFO - 'LANGUAGE': 'en_US:en', 21:32:42 INFO - 'LOGNAME': 'cltbld', 21:32:42 INFO - 'MAIL': '/var/mail/cltbld', 21:32:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:32:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:42 INFO - 'MOZ_NO_REMOTE': '1', 21:32:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:32:42 INFO - 'NO_EM_RESTART': '1', 21:32:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:42 INFO - 'PWD': '/builds/slave/test', 21:32:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:32:42 INFO - 'SHELL': '/bin/bash', 21:32:42 INFO - 'SHLVL': '1', 21:32:42 INFO - 'TERM': 'linux', 21:32:42 INFO - 'TMOUT': '86400', 21:32:42 INFO - 'USER': 'cltbld', 21:32:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971', 21:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:42 INFO - '_': '/tools/buildbot/bin/python'} 21:32:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 21:32:42 INFO - mozversion application_buildid: 20161006200200 21:32:42 INFO - mozversion application_changeset: e4333cfe24b97169233450f9010474464eeaff85 21:32:42 INFO - mozversion application_display_name: Nightly 21:32:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:32:42 INFO - mozversion application_name: Firefox 21:32:42 INFO - mozversion application_remotingname: firefox 21:32:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:32:42 INFO - mozversion application_vendor: Mozilla 21:32:42 INFO - mozversion application_version: 52.0a1 21:32:42 INFO - mozversion platform_buildid: 20161006200200 21:32:42 INFO - mozversion platform_changeset: e4333cfe24b97169233450f9010474464eeaff85 21:32:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:32:42 INFO - mozversion platform_version: 52.0a1 21:32:42 INFO - using testdate: 1475814762 21:32:42 INFO - actual date: 1475814762 21:32:42 INFO - starting webserver on 'localhost:42347' 21:32:42 INFO - SUITE-START | Running 2 tests 21:32:42 INFO - TEST-START | dromaeo_css 21:32:42 INFO - operating with platform_type : linux_ 21:32:42 INFO - Initialising browser for dromaeo_css test... 21:32:42 INFO - TEST-INFO | started process 22566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XBo5z/profile http://localhost:42347/getInfo.html) 21:32:47 INFO - PROCESS | 22566 | __metrics Screen width/height:1600/1200 21:32:47 INFO - PROCESS | 22566 | colorDepth:24 21:32:47 INFO - PROCESS | 22566 | Browser inner width/height: 1024/697 21:32:47 INFO - PROCESS | 22566 | __metrics 21:32:47 INFO - PROCESS | 22566 | 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" 21:32:47 INFO - PROCESS | 22566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:32:48 INFO - PROCESS | 22566 | console.error: PushService: 21:32:48 INFO - PROCESS | 22566 | stateChangeProcessEnqueue: Error transitioning state 21:32:48 INFO - PROCESS | 22566 | UnknownError 21:32:48 INFO - TEST-INFO | 22566: exit 0 21:32:48 INFO - Browser initialized. 21:32:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:32:48 INFO - TEST-INFO | started process 22646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XBo5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:00 INFO - PROCESS | 22646 | RSS: Main: 174882816 21:33:00 INFO - PROCESS | 22646 | 21:33:52 INFO - PROCESS | 22646 | 1475814832199 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] 21:36:05 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42347/tests/dromaeo/cssquery-ext.html) 21:36:07 INFO - PROCESS | 22646 | RSS: Main: 327811072 21:36:07 INFO - PROCESS | 22646 | 21:39:09 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-ext.html (next: http://localhost:42347/tests/dromaeo/cssquery-jquery.html) 21:39:10 INFO - PROCESS | 22646 | RSS: Main: 275419136 21:39:10 INFO - PROCESS | 22646 | 21:42:12 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42347/tests/dromaeo/cssquery-mootools.html) 21:42:13 INFO - PROCESS | 22646 | RSS: Main: 219938816 21:42:13 INFO - PROCESS | 22646 | 21:45:15 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42347/tests/dromaeo/cssquery-prototype.html) 21:45:16 INFO - PROCESS | 22646 | RSS: Main: 221184000 21:45:16 INFO - PROCESS | 22646 | 21:48:19 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42347/tests/dromaeo/cssquery-yui.html) 21:48:19 INFO - PROCESS | 22646 | RSS: Main: 223674368 21:48:19 INFO - PROCESS | 22646 | 21:51:22 INFO - PROCESS | 22646 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-yui.html (next: http://localhost:42347/tests/dromaeo/cssquery-dojo.html) 21:51:23 INFO - PROCESS | 22646 | RSS: Main: 311230464 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | __start_tp_report 21:51:23 INFO - PROCESS | 22646 | _x_x_mozilla_page_load 21:51:23 INFO - PROCESS | 22646 | _x_x_mozilla_page_load_details 21:51:23 INFO - PROCESS | 22646 | |i|pagename|runs| 21:51:23 INFO - PROCESS | 22646 | |0;dojo.html;2515.157422263542;2538.42885350796;2561.2444328922966;2578.0461229345146;2581.4449893272945;4478.193925093482;4530.161920044794;4537.591616754491;4555.08898220356;4559.4528656561215;4580.519045500225;4588.311753237016;4591.793369298382;4602.171609110359;4605.332226827108;4188.078622703;4211.915761684764;4219.409282700424;4247.235497610429;4283.978580107095;4184.3305071188615;4284.67864910133;4288.292431748758;4297.484301883778;4299.441072660566;4226.682998775089;4244.533101358848;4260.211860805761;4263.850765223217;4275.380069889879;4317.028668549583;4319.524852266248;4321.351797230409;4338.58783415575;4344.674149438789;4121.1345617420375;4157.833686652531;4159.209750147493;4215.662746980265;4292.635126014293;4568.063546972862;4581.885452863672;4591.862244132682;4602.033572949685;4617.538246175355;4949.059678661043;4950.183219768734;4953.479884612136;5001.299818025479;5031.748412579356;4818.951810481885;4897.485763994765;4997.30037794709;5006.8497945061345;5049.141645920203;4533.184026875161;4546.52261512543;4561.908761824745;4579.702319349231;4644.7213167210075;4985.853253751585;4987;4989.101961646866;4995.150824359867;5046.84859454217;4673.95326046742;4784.617230621542;4785.641076919245;4799.3760811094335;4859.368282123372;4814.518548145157;4880.219164933665;4948.505149485095;4949.851504454872;5019.121653710586;4909.705417674951;4916.852494425173;4917.385326834145;4929.7781599828095;4982.128127577659;4758.857234282977;4887;4905.509449055137;4906.1414252505665;4963;4106.117184805281;4109.794510274474;4120.958790412117;4138.503379594468;4151.56408577095;3614.4216925291826;3627.510286111394;3661.9816900915325;3663.6336366363153;3673.3755261605593;4281.293586558245;4283.357496375568;4283.87148385549;4284.485861696554;4338.110687309094;4803.975980120077;4850.369451971292;4850.975745121252;4934.432540257844;4978.551930326288;4370.672199585044;4392.538783427758;4395.604395604411;4405.383246345515;4408.713433626804;4481.865544033684;4489.663275254369;4495.43807024122;4499.955000450019;4517.954820451819;4706.835260765857;4712.175369310288;4713.2458806590785;4715.952840471551;4772.331873537777;4795.832145874878;4845.75771211445;4937.234728616926;4976.626752993468;4978.8755281118265;4714.5992590630185;4724.71651700899;4732.858014259577;4770.332153498443;4775.331453596569;4909.140900342497;4920.1389756791705;4921.63087768426;4922.778474968707;4982.302477653204;4843.564079232886;4863.197572400514;4882.389701287339;4884.0476107158765;4987.07739068259;4734.668573199843;4769.809207631656;4772.809087636595;4810.436608102451;4825.396825396825;4766.394771633227;4771.212749896228;4773.331733557374;4774.737389443475;4819.759012049453;4534.6599005074095;4663.626909847137;4669.4396672399525;4676.532346765296;4735.479097299225;4817.012512434872;4830.2996065571;4834.854954351375;4839.854804355875;4840.104580652591;4717.69334993238;4734.242521196592;4740.312654665123;4797.016611594545;4802.807887684454 21:51:23 INFO - PROCESS | 22646 | |1;ext.html;527.5937528103362;530.1438177343591;546.6556069676103;561.4666067236125;564.2664536103066;26784.196474105785;36643;37623.99999999996;37642.24715505688;41793;39347.83586902719;39820.20359592806;39823.80088099556;39830.40254396186;39832.20335593286;7569.545827250355;7710.691572337099;7711.4216433767415;7711.5758633275145;7713.1515533291295;7650.885236721454;7749.380049596019;7760.146383897795;7761.922380776176;7764.534127952313;7737.613119344011;7759.728409505668;7775.30022297993;7779.611019449005;7784.961075194645;7627.923720762805;7728.536287822721;7745.883811742829;7751.984484034192;7753.302202801775;7621.771346859603;7698.114716807583;7700.3069723724575;7703.807404814925;7704.229577042307;35960.64039359625;36095.81952090249;36158.276834463424;36177;36194.276114477565;2568.8844002019955;2673.4786716590274;2703.2836298380944;2966.036038287565;3211.341674956628;27367.452650947067;27505.587416188773;27622.856571514432;28265.293367665767;28361.290967725767;3415.5389022481895;3438.2607739335913;3485.8082805445692;3566.1262990567216;3573.0352804742574;228344;229021;229155;229738;231274;48277.51722482801;48982.26526602104;49239;49271.50728492741;49586.50413495819;51210.74394628003;51247.74376128095;51259.77324081626;51305;51306.23040654393;14110.365033573515;14902.627434314229;14977.251137443085;14987.32557034936;15360.923195384175;11192;11346.886531134747;11352.580927384077;11357.545698172145;11384.48769805344;17338.566535836453;17341.7398739019;17357.47927562175;17358.91320543389;17491.737623935653;6636.170478690164;6656.70044847983;6658.201015878126;6704.3295670433545;6917.377436030782;754.4907187648315;790.8734602463693;876.3339861705023;882.7660669922476;933.869258303838;26029.73970260311;27256.86371568169;27843.721562784518;27862.164135075982;27900;761.9276168763959;936.4053825820653;950.1686024728363;953.2659851914126;990.895955924632;13293.301480746455;14178.291085445686;14414.711705765825;14649.267536623127;14655.706885862222;338005;342525;343155;343314;343374;47273;47593.286100708516;47654.5234547657;47728;47773.28340074902;1026.4559783314855;1072.9678109656722;1083.5774048121398;1135.5457816873318;1168.2348062019391;25254.74745252524;28048.579271311355;29733.256668583457;30836.383272334875;31080.533791992686;45418.09163816639;45968.31047534223;45999.77000115112;46005.76997114993;46040.53959460497;307944;312276;312448;313429;313913;24250.63624045676;24682.50634987326;25017;25144.11419143535;25175;38632.42051369288;39194.412083819334;39846;40125.59874401218;40193;33682.49476257809;34117.80587679419;34155.316893662486;34417.82791086029;34775.478367824;34462;34485.58600897913;34895.82552087223;34911.82544087365;34989.30021399609;27846;33646.32707345888;34550;34589;37602.24795504129;29969.400611988076;31805.522917156723;32334.676653233168;32500.674993249766;32507.837460812545;24600.443260203272;24876;24997.75002250027;25195;25472.235832925042 21:51:23 INFO - PROCESS | 22646 | |2;jquery.html;362.92560025194837;365.2366553902344;366.16697014292487;382.0963421508131;383.24500733554885;16051.759223611654;16128;16623.91688041558;16707.331706731748;16721.83278167218;14633.268336583182;15746.606334841636;16306.918465407685;16428.260728267225;16438.095904725236;4858.635602329813;5129.153689641204;5130.2817605535065;5132.692038477685;5138.22926561017;3648.1244501319625;3835.175437280984;3840.7695538267794;3888.988862895639;5029.094762942669;3875.4961854958815;3879.9612003880025;3901.4668920627164;6021.45806877381;6051.152838602599;5780.364159942403;5826.883462330751;5982.162497250389;5982.730777115018;5988.31134419543;5150.175971844487;5176.482351764794;5182.663126896739;5184.092783762864;5185.351831021122;16472.176391180394;16599;17712.114394280234;18472.261109555602;18602.162902669414;1771.7873855137336;1803.7023891057959;1931.0563373307893;2096.7693553709078;2363.5981883079917;9046.592903319366;9259.30555208362;11721.589744358907;11952.581659641957;13182.077254592183;1607.8794090443146;1628.9266982985794;1746.9650606987916;1751.903645299508;1756.7540544323806;54856.177157342674;62066.68966655138;62762;68382.31617683859;70210.2978970214;9397.765055873659;9520.952395237979;9560.808783824423;9726.951365243129;9900.851487227697;13325.73348533024;13327.400266988008;13342.19946803195;13343.466261349631;13371.264580448169;6950.54821436605;7030.6484675766005;7152.213256541776;7214.92785072153;7260.745873894494;6743.758030350454;6756.391924726799;6887.2079710832895;6962.443004559623;6984.2317345092;4054.878353649395;4092.6725861930972;4135.648469880034;4177.519585247735;4210.136921930997;1730.3597668862349;1738.582740142382;1769.0638329716535;1814.7277908313858;1818.2545156485778;781.3709963479454;823.8887750153652;830.5390508267969;882.6116508736136;901.3960646366819;15036.398544058335;15986.76019859703;16014.359425622844;16486.75269870953;16876.409325673543;831.2352635575164;832.6835802395051;842.1914961636897;853.7225401744458;876.9561521923878;8885.733427997171;9170.724878253663;9363.812723745486;9490.762730931781;9636.662716804878;266003;266825;267094;359154;363860;74576;77736;77825;78810.60594697105;79539.60230198812;885.1104639836923;891.1266958380824;912.1927094521396;921.2629896083107;926.4395041000232;14538;14809.481668141563;15075.54773356801;15259.389624414898;15421.768673469682;36127.45808812817;36177.819110904275;36458.63541364553;36741.22364092651;37489.625103749706;48863.5113648859;49068.263976041104;49136.50863491462;49241;49347.25979110244;6580.76967306142;7382.630868456663;7397.963010184914;7498.512596681198;7982.042154941212;8176.918230817616;10576.788464230825;11476.713082172679;11498.310101393943;11622;10116.443595602312;10205.438700871226;10374.066334029974;10478.842817357898;10549.419781912069;9870.259730520096;10231.641892533726;10426.947865260625;10495.422751748727;10538.736531586772;9930.205583553443;9934.751631209278;10013.19894408431;10104.949475252577;10283.12593429567;7563.205863384265;7712.768616941501;7758.4181186410115;7902.407319450949;7960.522368657899;9018.909810901807;9385.953070234878;9840.409575425498;9965.451900145561;9980.750481238027 21:51:23 INFO - PROCESS | 22646 | |3;mootools.html;1191.34476038179;1314.0407502523158;1338.250579675382;1374.5395292576986;1641.2450272874478;6338.524610654202;7077.646117694114;7350.963245183767;7357.852842943144;7537.773866783991;7367.631618419085;7426.368758655521;7428.851422971537;7433.219511951235;7439.888401673979;1849.9075046247667;1858.1731129647312;1858.804825493324;1865.4123950955407;1867.5144462439796;1842.3643842874187;1883.9811601883944;1884.5194475408753;1889.0177107903883;1890.7447494588191;1797.263122119931;1812.9093545322746;1816.6094289727705;1817.2549254805533;1820.1263393571028;1753.403842693484;1819.5360183153343;1821.4608655685925;1822.0889555222388;1824.6624374490762;1760.9735853962202;1799.8290162434548;1802.7295905614133;1803.9819601803945;1806.665766833127;7184.928150718531;7293.343599076055;7321.963390183068;7359.337659610661;7359.963200184018;4262.829486820523;4443.822247110112;4462.977685111586;4463;4465.531119232466;2643.193825883105;2782.8886844526196;2796.049343223314;2826.053272153831;2835.8723857426257;904.7150147703518;908.8330006918287;929.2937367600672;931.7903471718809;940.1397721085199;9900.405975641484;9971.90028099717;10012;10018.799624007479;10019.048190421898;3501.439769636846;3567.8572857085946;3650.452432135201;3711.2948539777894;3729.8321575529167;7984.08183058944;7993.040835099825;7996;7997.800054998672;8001.759947201594;4297.914041719148;4300.204462174508;4301.935470967938;4303.548127446573;4307.203167413976;3422.1102513346214;3551.5383000210322;3978.602139785998;3995.2409042281874;4001.3197756381487;3049.618797650294;3063.9540406893916;3176.2377029513214;3201.6798320168264;3205.743540516753;973.756560859785;978.6232300564334;984.7931934293879;986.4229425785852;995.7809281957958;695.3012222716138;721.8953251778463;733.4205977277891;745.198911170494;751.9661615227328;4802.351682522814;4816.590589799836;4927.975360123177;4990.226514890198;5070.974645126825;796.482286513759;843.8185790055045;885.154677283193;900.243795212025;935.050923312838;3316.7512436567354;3413.8293085345636;3423.5549378580627;3441.6558344165883;3481.3559491493647;8566.742997710078;8907.465552066897;8914.643414263486;8933.374663773604;8934.910650893538;8857.601407936529;8881.911180888237;8886.644534218689;8903.287736981027;8915.643374264957;6811.863762724817;6812.727490900407;6977.720891164398;6991.510594258353;7000.264972177848;4726.432828060655;4792.257200133985;4866.075445665312;4866.853994380032;5082.339295891658;8034.718784842503;8171.877421838558;8196.30331421812;8255.669773209005;8349.373796965374;8342;8421.368397370099;8468.153184681729;8468.280196183394;8491.490510569385;5874.265716785402;5970.701464926823;5974.6713930732485;5979.133025711334;5979.760809567742;6769.898451523132;6980.232174460703;7003.3346832050875;7182.748603798842;7183.20984691673;6202.875942481215;6277.717502712298;6301.779437719658;6385.489160867212;6544.8363790905605;6065.939340606714;6144.8771024580155;6149.7847575334645;6205.968970155121;6310.148130002391;5710.486056254957;5816.47651711348;5826.300843898759;5851.063829787214;5859.326177489644;4083.285425050664;4119.443875076826;4175.87472375817;4191.392248124066;4211.852585159505;4445.133199026288;4453.398791163151;4502.57225563571;4518.118966801442;4664.696794708333 21:51:23 INFO - PROCESS | 22646 | |4;prototype.html;268.9247010836966;270.27963546900446;276.34092688936903;277.3869747857234;280.5917390197263;4359.237133501632;4592.807998441085;4812.831550895715;4836.17784976554;4844.128056949743;4653.488116307212;4746.24060150376;4750.9072913229975;4757.430048084133;4769.427668679755;3743.382341913581;3751.8311675974646;3760.717946154036;3766.6986641068647;3767.491388662537;3471.6701913318193;3600.207954250061;3611.1694310308644;3703.925921481569;3731.75743576668;3664.413693808991;3682.576503702082;3684.1894783147663;3685.4287585424304;3686.3548878946076;3672.7429079964413;3682.355587772129;3690.7785532868115;3695.5195824542907;3699.5375578052744;3036.5748795168693;3226.6934641209045;3234.91912702182;3246.6428692844006;3250.1874531367157;4619.030003699228;4646.256598944153;4664.440267167927;4664.510226426244;4671.85984420468;4177.248095342868;4182.1008483176265;4187.623113919732;4189.49726032878;4190.958090419087;4789.616830653539;4946.87632809179;4972.477889821553;5007.824726134568;5012.799488020475;3454.758166928316;3457.11843479911;3459.9481007784902;3465.462853257749;3473.2532505511185;5010.599152067826;5207.817726379596;5252.343457067866;5267.947320526822;5275.28783614211;3391.1522119470133;3414.6585341466152;3476.269983303484;3506.4389697648253;3507.4037413639744;3523.982380088083;3553.911152221215;3553.9466907996402;3555.3690269201124;3563.1448452371765;4119.073208528117;4121.258173528734;4126.071633882352;4130.442390277334;4135.648469880094;4832.9275060874115;4983.6013118950395;5013.8718788272345;5026.371703537058;5033.622478314068;1211.3761412872377;1220.6094049904123;1223.9265644061384;1224.5163160551533;1232.6363722701824;758.3440324119707;773.4972268025716;790.2334735306744;790.920907909216;796.6693822063894;3986.8405263789705;3997.0621593129026;3999.800159872149;4005.379166229239;4012.558618551957;4529.84145554904;4535.752668016322;4555.33947577606;4559.4072770539615;4602.539746025371;3956.5647778744315;4042.2521833460905;4054.5134583849535;4069.7965101744794;4089.3252613319064;2268.4895898422724;2408.879556022227;2421.32202983165;2427.490227052339;2441.5727247731575;4296.3555466680245;4300.741955482681;4341.869743907688;4354.303311470149;4356.1921802451625;4650.395448591661;4662.510436404196;4668.8132474701315;4678.836240731558;4684.641453978376;4082.4692789937117;4277.422547956111;4305.6986010978935;4311.030018245932;4313.547077556811;4514.88712782183;4536.8638940831825;4543.341215523797;4567.337736028324;4576.244919588231;4443.600075993176;4510.188166130128;4512.691319517435;4535.3650488932235;4547.136044151601;4068.2099876055627;4318;4356.49900261474;4357.651387888898;4365.388845561687;3261.5433839262046;3263.3473305339503;3267.460868956691;3291.753118516073;3308.801471911693;4534.274516077412;4562;4566.725996440225;4579.381783459324;4612.907741845212;4407.801648925742;4441.911161776811;4453.955460445483;4466.865994020184;4482.641388688832;4378.124375125051;4576.58810707038;5007.9733654599995;5049.2426136079885;5054.873628159178;4936.851894443173;4941.407031156285;4942.92585611209;4943.975280123576;4944;5111.769970351269;5124.256982737407;5132.384113906355;5141.971605678805;5149.124648809786;4854.854354369375;4941.777620007037;4956.454789973172;4977.481868030285;4983.327250821238 21:51:23 INFO - PROCESS | 22646 | |5;yui.html;599.2479438304927;603.4237303375277;628.3779058731857;671.6507416143605;714.7391202211195;12263.386830658465;13427.798583021238;13446.126001809887;13456.730865382686;13467.730645387086;13051.347432628378;13143.737125257512;13179.60461186166;13180;13181.20912745236;588.1060787602842;605.2887856768301;740.7222291640621;744.6128013433039;755.8374949385881;746.8319628083665;750.0961341583379;750.2235186581889;750.3059669805408;751.3538357012992;793.9603019849013;796.2356138107394;796.4584082823677;797.6889013284795;797.996010019949;609.5276160975258;627.438442593876;628.4249911331173;629.3360504667573;791.0981481111509;467.3247157856898;570.361195461082;585.1749033862234;586.7652938824505;587.7913340764053;12949.287789171593;12955.935220323838;12997.610071697864;12997.610071697864;13002.219866808022;11754.706132346675;12272.877271227262;12610.684732881751;12777.616671499869;12841;11009.28439651428;11174.776504469864;11202.66392008241;11260.718482037933;11365.829512557319;4027.254957832781;4056.7565946043333;4066.63400293972;4073.6130067643526;4094.2016306820183;57632.71183644097;57664.42335576675;57681;57730.422695772926;58501.122483162784;9330.30022748283;9340.766480838034;9489.145976862115;9569.473678947585;9905.207583393456;17395.304187832597;17716;17751.644967100845;17771.555711107325;17801.910990445223;6438.935610643927;6450.161479007793;6483.481321494269;6580.8354791130605;6618;3528.4530897710897;3550.1302180965827;3569.6430356964615;3576.8926932192076;3578.1949061460964;2661.467706458716;2773.1541879726474;2777.4306267215175;2779.2634951737805;3024.7882648214854;520.4327283261264;520.6537652461146;524.090702630935;526.6945171800346;535.1651423778917;462.17732436263503;549.5658429840461;567.8026039228213;576.9153990497837;628.9748410063546;7922.524648521107;8031.759047228593;8060.717874874351;8196.877046844302;8268.586570671443;554.6810583914184;559.6166625861298;571.5798887817451;571.6198727846019;585.6193474241777;3716.758410703296;3846.5961074087377;4051.8379264829077;4108.8356465741035;4159.376093585925;97442.51278743702;99789.50105249428;101367.49316253519;104142;104225;83457.58271208605;85468;87728.56135719281;89400.55299723589;90116;77646;77818.61090694624;78435.2156478428;78450;79210.6039469799;7649.426293027934;7892.684292628231;7991.960040199761;8161.183881612029;8205.138460461805;39841;45274.54725452703;46683.76658116688;47148.764256178496;47156;61450.38549614626;63869.36130638634;66671.66664166648;67503.3249667497;70189.64905175442;9256.166944974984;9622.13400793932;9627.951860240933;9698.321117521988;9758.170555502578;11153;11166.888331116585;11269.830952535882;11421.257618254787;11979.221350612183;9831.115199632068;10118.49407529606;10459.738506537398;10483.274348669249;10520.894791051991;10359.689209323733;10409;10489.947550262199;10701.090407315465;10998.835017474905;9965.800683986135;10130.696079117639;10165.949170254102;10695.090917272119;10696.251262411868;8192.426530143071;8442.574257425742;8451.197136272045;8507.300108927158;8835.779105522413;8578.785530361542;8775.780605484913;8953.238974687225;9054.637814487347;9425 21:51:23 INFO - PROCESS | 22646 | __end_tp_report 21:51:23 INFO - PROCESS | 22646 | __start_cc_report 21:51:23 INFO - PROCESS | 22646 | _x_x_mozilla_cycle_collect,1557 21:51:23 INFO - PROCESS | 22646 | __end_cc_report 21:51:23 INFO - PROCESS | 22646 | __startTimestamp1475815883115__endTimestamp 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | ------- Summary: start ------- 21:51:23 INFO - PROCESS | 22646 | Number of tests: 6 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#0] dojo.html Cycles:165 Average:4558.19 Median:4713.25 stddev:474.32 (10.1%) stddev-sans-first:447.88 21:51:23 INFO - PROCESS | 22646 | Values: 2515.2 2538.4 2561.2 2578.0 2581.4 4478.2 4530.2 4537.6 4555.1 4559.5 4580.5 4588.3 4591.8 4602.2 4605.3 4188.1 4211.9 4219.4 4247.2 4284.0 4184.3 4284.7 4288.3 4297.5 4299.4 4226.7 4244.5 4260.2 4263.9 4275.4 4317.0 4319.5 4321.4 4338.6 4344.7 4121.1 4157.8 4159.2 4215.7 4292.6 4568.1 4581.9 4591.9 4602.0 4617.5 4949.1 4950.2 4953.5 5001.3 5031.7 4819.0 4897.5 4997.3 5006.8 5049.1 4533.2 4546.5 4561.9 4579.7 4644.7 4985.9 4987.0 4989.1 4995.2 5046.8 4674.0 4784.6 4785.6 4799.4 4859.4 4814.5 4880.2 4948.5 4949.9 5019.1 4909.7 4916.9 4917.4 4929.8 4982.1 4758.9 4887.0 4905.5 4906.1 4963.0 4106.1 4109.8 4121.0 4138.5 4151.6 3614.4 3627.5 3662.0 3663.6 3673.4 4281.3 4283.4 4283.9 4284.5 4338.1 4804.0 4850.4 4851.0 4934.4 4978.6 4370.7 4392.5 4395.6 4405.4 4408.7 4481.9 4489.7 4495.4 4500.0 4518.0 4706.8 4712.2 4713.2 4716.0 4772.3 4795.8 4845.8 4937.2 4976.6 4978.9 4714.6 4724.7 4732.9 4770.3 4775.3 4909.1 4920.1 4921.6 4922.8 4982.3 4843.6 4863.2 4882.4 4884.0 4987.1 4734.7 4769.8 4772.8 4810.4 4825.4 4766.4 4771.2 4773.3 4774.7 4819.8 4534.7 4663.6 4669.4 4676.5 4735.5 4817.0 4830.3 4834.9 4839.9 4840.1 4717.7 4734.2 4740.3 4797.0 4802.8 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#1] ext.html Cycles:180 Average:44731.38 Median:34903.83 stddev:78314.73 (224.4%) stddev-sans-first:78464.09 21:51:23 INFO - PROCESS | 22646 | Values: 527.6 530.1 546.7 561.5 564.3 26784.2 36643.0 37624.0 37642.2 41793.0 39347.8 39820.2 39823.8 39830.4 39832.2 7569.5 7710.7 7711.4 7711.6 7713.2 7650.9 7749.4 7760.1 7761.9 7764.5 7737.6 7759.7 7775.3 7779.6 7785.0 7627.9 7728.5 7745.9 7752.0 7753.3 7621.8 7698.1 7700.3 7703.8 7704.2 35960.6 36095.8 36158.3 36177.0 36194.3 2568.9 2673.5 2703.3 2966.0 3211.3 27367.5 27505.6 27622.9 28265.3 28361.3 3415.5 3438.3 3485.8 3566.1 3573.0 228344.0 229021.0 229155.0 229738.0 231274.0 48277.5 48982.3 49239.0 49271.5 49586.5 51210.7 51247.7 51259.8 51305.0 51306.2 14110.4 14902.6 14977.3 14987.3 15360.9 11192.0 11346.9 11352.6 11357.5 11384.5 17338.6 17341.7 17357.5 17358.9 17491.7 6636.2 6656.7 6658.2 6704.3 6917.4 754.5 790.9 876.3 882.8 933.9 26029.7 27256.9 27843.7 27862.2 27900.0 761.9 936.4 950.2 953.3 990.9 13293.3 14178.3 14414.7 14649.3 14655.7 338005.0 342525.0 343155.0 343314.0 343374.0 47273.0 47593.3 47654.5 47728.0 47773.3 1026.5 1073.0 1083.6 1135.5 1168.2 25254.7 28048.6 29733.3 30836.4 31080.5 45418.1 45968.3 45999.8 46005.8 46040.5 307944.0 312276.0 312448.0 313429.0 313913.0 24250.6 24682.5 25017.0 25144.1 25175.0 38632.4 39194.4 39846.0 40125.6 40193.0 33682.5 34117.8 34155.3 34417.8 34775.5 34462.0 34485.6 34895.8 34911.8 34989.3 27846.0 33646.3 34550.0 34589.0 37602.2 29969.4 31805.5 32334.7 32500.7 32507.8 24600.4 24876.0 24997.8 25195.0 25472.2 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#2] jquery.html Cycles:180 Average:21491.44 Median:4534.39 stddev:51479.79 (1135.3%) stddev-sans-first:51599.76 21:51:23 INFO - PROCESS | 22646 | Values: 362.9 365.2 366.2 382.1 383.2 16051.8 16128.0 16623.9 16707.3 16721.8 14633.3 15746.6 16306.9 16428.3 16438.1 4858.6 5129.2 5130.3 5132.7 5138.2 3648.1 3835.2 3840.8 3889.0 5029.1 3875.5 3880.0 3901.5 6021.5 6051.2 5780.4 5826.9 5982.2 5982.7 5988.3 5150.2 5176.5 5182.7 5184.1 5185.4 16472.2 16599.0 17712.1 18472.3 18602.2 1771.8 1803.7 1931.1 2096.8 2363.6 9046.6 9259.3 11721.6 11952.6 13182.1 1607.9 1628.9 1747.0 1751.9 1756.8 54856.2 62066.7 62762.0 68382.3 70210.3 9397.8 9521.0 9560.8 9727.0 9900.9 13325.7 13327.4 13342.2 13343.5 13371.3 6950.5 7030.6 7152.2 7214.9 7260.7 6743.8 6756.4 6887.2 6962.4 6984.2 4054.9 4092.7 4135.6 4177.5 4210.1 1730.4 1738.6 1769.1 1814.7 1818.3 781.4 823.9 830.5 882.6 901.4 15036.4 15986.8 16014.4 16486.8 16876.4 831.2 832.7 842.2 853.7 877.0 8885.7 9170.7 9363.8 9490.8 9636.7 266003.0 266825.0 267094.0 359154.0 363860.0 74576.0 77736.0 77825.0 78810.6 79539.6 885.1 891.1 912.2 921.3 926.4 14538.0 14809.5 15075.5 15259.4 15421.8 36127.5 36177.8 36458.6 36741.2 37489.6 48863.5 49068.3 49136.5 49241.0 49347.3 6580.8 7382.6 7398.0 7498.5 7982.0 8176.9 10576.8 11476.7 11498.3 11622.0 10116.4 10205.4 10374.1 10478.8 10549.4 9870.3 10231.6 10426.9 10495.4 10538.7 9930.2 9934.8 10013.2 10104.9 10283.1 7563.2 7712.8 7758.4 7902.4 7960.5 9018.9 9386.0 9840.4 9965.5 9980.8 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#3] mootools.html Cycles:180 Average:4733.76 Median:5838.68 stddev:2691.89 (46.1%) stddev-sans-first:2686.28 21:51:23 INFO - PROCESS | 22646 | Values: 1191.3 1314.0 1338.3 1374.5 1641.2 6338.5 7077.6 7351.0 7357.9 7537.8 7367.6 7426.4 7428.9 7433.2 7439.9 1849.9 1858.2 1858.8 1865.4 1867.5 1842.4 1884.0 1884.5 1889.0 1890.7 1797.3 1812.9 1816.6 1817.3 1820.1 1753.4 1819.5 1821.5 1822.1 1824.7 1761.0 1799.8 1802.7 1804.0 1806.7 7184.9 7293.3 7322.0 7359.3 7360.0 4262.8 4443.8 4463.0 4463.0 4465.5 2643.2 2782.9 2796.0 2826.1 2835.9 904.7 908.8 929.3 931.8 940.1 9900.4 9971.9 10012.0 10018.8 10019.0 3501.4 3567.9 3650.5 3711.3 3729.8 7984.1 7993.0 7996.0 7997.8 8001.8 4297.9 4300.2 4301.9 4303.5 4307.2 3422.1 3551.5 3978.6 3995.2 4001.3 3049.6 3064.0 3176.2 3201.7 3205.7 973.8 978.6 984.8 986.4 995.8 695.3 721.9 733.4 745.2 752.0 4802.4 4816.6 4928.0 4990.2 5071.0 796.5 843.8 885.2 900.2 935.1 3316.8 3413.8 3423.6 3441.7 3481.4 8566.7 8907.5 8914.6 8933.4 8934.9 8857.6 8881.9 8886.6 8903.3 8915.6 6811.9 6812.7 6977.7 6991.5 7000.3 4726.4 4792.3 4866.1 4866.9 5082.3 8034.7 8171.9 8196.3 8255.7 8349.4 8342.0 8421.4 8468.2 8468.3 8491.5 5874.3 5970.7 5974.7 5979.1 5979.8 6769.9 6980.2 7003.3 7182.7 7183.2 6202.9 6277.7 6301.8 6385.5 6544.8 6065.9 6144.9 6149.8 6206.0 6310.1 5710.5 5816.5 5826.3 5851.1 5859.3 4083.3 4119.4 4175.9 4191.4 4211.9 4445.1 4453.4 4502.6 4518.1 4664.7 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#4] prototype.html Cycles:180 Average:3942.98 Median:4355.25 stddev:1152.70 (26.5%) stddev-sans-first:1122.46 21:51:23 INFO - PROCESS | 22646 | Values: 268.9 270.3 276.3 277.4 280.6 4359.2 4592.8 4812.8 4836.2 4844.1 4653.5 4746.2 4750.9 4757.4 4769.4 3743.4 3751.8 3760.7 3766.7 3767.5 3471.7 3600.2 3611.2 3703.9 3731.8 3664.4 3682.6 3684.2 3685.4 3686.4 3672.7 3682.4 3690.8 3695.5 3699.5 3036.6 3226.7 3234.9 3246.6 3250.2 4619.0 4646.3 4664.4 4664.5 4671.9 4177.2 4182.1 4187.6 4189.5 4191.0 4789.6 4946.9 4972.5 5007.8 5012.8 3454.8 3457.1 3459.9 3465.5 3473.3 5010.6 5207.8 5252.3 5267.9 5275.3 3391.2 3414.7 3476.3 3506.4 3507.4 3524.0 3553.9 3553.9 3555.4 3563.1 4119.1 4121.3 4126.1 4130.4 4135.6 4832.9 4983.6 5013.9 5026.4 5033.6 1211.4 1220.6 1223.9 1224.5 1232.6 758.3 773.5 790.2 790.9 796.7 3986.8 3997.1 3999.8 4005.4 4012.6 4529.8 4535.8 4555.3 4559.4 4602.5 3956.6 4042.3 4054.5 4069.8 4089.3 2268.5 2408.9 2421.3 2427.5 2441.6 4296.4 4300.7 4341.9 4354.3 4356.2 4650.4 4662.5 4668.8 4678.8 4684.6 4082.5 4277.4 4305.7 4311.0 4313.5 4514.9 4536.9 4543.3 4567.3 4576.2 4443.6 4510.2 4512.7 4535.4 4547.1 4068.2 4318.0 4356.5 4357.7 4365.4 3261.5 3263.3 3267.5 3291.8 3308.8 4534.3 4562.0 4566.7 4579.4 4612.9 4407.8 4441.9 4454.0 4466.9 4482.6 4378.1 4576.6 5008.0 5049.2 5054.9 4936.9 4941.4 4942.9 4944.0 4944.0 5111.8 5124.3 5132.4 5142.0 5149.1 4854.9 4941.8 4956.5 4977.5 4983.3 21:51:23 INFO - PROCESS | 22646 | 21:51:23 INFO - PROCESS | 22646 | [#5] yui.html Cycles:180 Average:17736.83 Median:29104.81 stddev:26210.54 (90.1%) stddev-sans-first:26252.48 21:51:23 INFO - PROCESS | 22646 | Values: 599.2 603.4 628.4 671.7 714.7 12263.4 13427.8 13446.1 13456.7 13467.7 13051.3 13143.7 13179.6 13180.0 13181.2 588.1 605.3 740.7 744.6 755.8 746.8 750.1 750.2 750.3 751.4 794.0 796.2 796.5 797.7 798.0 609.5 627.4 628.4 629.3 791.1 467.3 570.4 585.2 586.8 587.8 12949.3 12955.9 12997.6 12997.6 13002.2 11754.7 12272.9 12610.7 12777.6 12841.0 11009.3 11174.8 11202.7 11260.7 11365.8 4027.3 4056.8 4066.6 4073.6 4094.2 57632.7 57664.4 57681.0 57730.4 58501.1 9330.3 9340.8 9489.1 9569.5 9905.2 17395.3 17716.0 17751.6 17771.6 17801.9 6438.9 6450.2 6483.5 6580.8 6618.0 3528.5 3550.1 3569.6 3576.9 3578.2 2661.5 2773.2 2777.4 2779.3 3024.8 520.4 520.7 524.1 526.7 535.2 462.2 549.6 567.8 576.9 629.0 7922.5 8031.8 8060.7 8196.9 8268.6 554.7 559.6 571.6 571.6 585.6 3716.8 3846.6 4051.8 4108.8 4159.4 97442.5 99789.5 101367.5 104142.0 104225.0 83457.6 85468.0 87728.6 89400.6 90116.0 77646.0 77818.6 78435.2 78450.0 79210.6 7649.4 7892.7 7992.0 8161.2 8205.1 39841.0 45274.5 46683.8 47148.8 47156.0 61450.4 63869.4 66671.7 67503.3 70189.6 9256.2 9622.1 9628.0 9698.3 9758.2 11153.0 11166.9 11269.8 11421.3 11979.2 9831.1 10118.5 10459.7 10483.3 10520.9 10359.7 10409.0 10489.9 10701.1 10998.8 9965.8 10130.7 10165.9 10695.1 10696.3 8192.4 8442.6 8451.2 8507.3 8835.8 8578.8 8775.8 8953.2 9054.6 9425.0 21:51:23 INFO - PROCESS | 22646 | -------- Summary: end -------- 21:51:23 INFO - PROCESS | 22646 | 21:51:24 INFO - TEST-INFO | 22646: exit 0 21:51:24 INFO - TEST-OK | dromaeo_css | took 1121692ms 21:51:24 INFO - TEST-START | kraken 21:51:24 INFO - operating with platform_type : linux_ 21:51:24 INFO - Initialising browser for kraken test... 21:51:24 INFO - TEST-INFO | started process 22948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_Ydwv/profile http://localhost:42347/getInfo.html) 21:51:28 INFO - PROCESS | 22948 | __metrics Screen width/height:1600/1200 21:51:28 INFO - PROCESS | 22948 | colorDepth:24 21:51:28 INFO - PROCESS | 22948 | Browser inner width/height: 1024/697 21:51:28 INFO - PROCESS | 22948 | __metrics 21:51:29 INFO - PROCESS | 22948 | 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" 21:51:29 INFO - PROCESS | 22948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:51:29 INFO - PROCESS | 22948 | console.error: PushService: 21:51:29 INFO - PROCESS | 22948 | stateChangeProcessEnqueue: Error transitioning state 21:51:29 INFO - PROCESS | 22948 | UnknownError 21:51:30 INFO - TEST-INFO | 22948: exit 0 21:51:30 INFO - Browser initialized. 21:51:30 INFO - Running cycle 1/1 for kraken test... 21:51:30 INFO - TEST-INFO | started process 23030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_Ydwv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:42 INFO - PROCESS | 23030 | RSS: Main: 174596096 21:51:42 INFO - PROCESS | 23030 | 21:51:45 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-beat-detection) 21:51:46 INFO - PROCESS | 23030 | RSS: Main: 232763392 21:51:46 INFO - PROCESS | 23030 | 21:51:48 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-dft) 21:51:49 INFO - PROCESS | 23030 | RSS: Main: 217956352 21:51:49 INFO - PROCESS | 23030 | 21:51:52 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-fft) 21:51:53 INFO - PROCESS | 23030 | RSS: Main: 300019712 21:51:53 INFO - PROCESS | 23030 | 21:51:55 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-oscillator) 21:51:56 INFO - PROCESS | 23030 | RSS: Main: 211099648 21:51:56 INFO - PROCESS | 23030 | 21:51:58 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:51:59 INFO - PROCESS | 23030 | RSS: Main: 214077440 21:51:59 INFO - PROCESS | 23030 | 21:52:02 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-darkroom) 21:52:02 INFO - PROCESS | 23030 | RSS: Main: 250089472 21:52:02 INFO - PROCESS | 23030 | 21:52:06 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-desaturate) 21:52:06 INFO - PROCESS | 23030 | RSS: Main: 249331712 21:52:06 INFO - PROCESS | 23030 | 21:52:09 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42347/tests/kraken/driver.html?testName=json-parse-financial) 21:52:10 INFO - PROCESS | 23030 | RSS: Main: 248745984 21:52:10 INFO - PROCESS | 23030 | 21:52:12 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:52:12 INFO - PROCESS | 23030 | RSS: Main: 211062784 21:52:12 INFO - PROCESS | 23030 | 21:52:14 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:52:15 INFO - PROCESS | 23030 | RSS: Main: 218611712 21:52:15 INFO - PROCESS | 23030 | 21:52:17 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:52:17 INFO - PROCESS | 23030 | RSS: Main: 227323904 21:52:17 INFO - PROCESS | 23030 | 21:52:20 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:52:21 INFO - PROCESS | 23030 | RSS: Main: 236425216 21:52:21 INFO - PROCESS | 23030 | 21:52:24 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:52:25 INFO - PROCESS | 23030 | RSS: Main: 232435712 21:52:25 INFO - PROCESS | 23030 | 21:52:26 INFO - PROCESS | 23030 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42347/tests/kraken/driver.html?testName=ai-astar) 21:52:27 INFO - PROCESS | 23030 | RSS: Main: 283459584 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | __start_tp_report 21:52:27 INFO - PROCESS | 23030 | _x_x_mozilla_page_load 21:52:27 INFO - PROCESS | 23030 | _x_x_mozilla_page_load_details 21:52:27 INFO - PROCESS | 23030 | |i|pagename|runs| 21:52:27 INFO - PROCESS | 23030 | |0;ai-astar;112;114;113;112;113;113;114;114;113;113 21:52:27 INFO - PROCESS | 23030 | |1;audio-beat-detection;156;125;132;179;130;128;127;134;165;133 21:52:27 INFO - PROCESS | 23030 | |2;audio-dft;161;161;162;162;162;161;162;162;162;161 21:52:27 INFO - PROCESS | 23030 | |3;audio-fft;76;85;76;120;78;78;78;76;109;76 21:52:27 INFO - PROCESS | 23030 | |4;audio-oscillator;85;83;113;83;85;84;114;84;83;121 21:52:27 INFO - PROCESS | 23030 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 21:52:27 INFO - PROCESS | 23030 | |6;imaging-darkroom;146;146;146;147;147;146;146;146;146;146 21:52:27 INFO - PROCESS | 23030 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;95;94 21:52:27 INFO - PROCESS | 23030 | |8;json-parse-financial;64;63;62;63;65;64;63;65;65;65 21:52:27 INFO - PROCESS | 23030 | |9;json-stringify-tinderbox;65;66;65;66;67;65;65;66;65;66 21:52:27 INFO - PROCESS | 23030 | |10;stanford-crypto-aes;82;84;89;82;83;83;83;83;81;82 21:52:27 INFO - PROCESS | 23030 | |11;stanford-crypto-ccm;147;141;142;151;138;146;140;138;181;148 21:52:27 INFO - PROCESS | 23030 | |12;stanford-crypto-pbkdf2;177;175;177;175;176;179;176;173;174;179 21:52:27 INFO - PROCESS | 23030 | |13;stanford-crypto-sha256-iterative;70;71;70;74;70;72;70;70;69;68 21:52:27 INFO - PROCESS | 23030 | __end_tp_report 21:52:27 INFO - PROCESS | 23030 | __start_cc_report 21:52:27 INFO - PROCESS | 23030 | _x_x_mozilla_cycle_collect,1915 21:52:27 INFO - PROCESS | 23030 | __end_cc_report 21:52:27 INFO - PROCESS | 23030 | __startTimestamp1475815947216__endTimestamp 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | ------- Summary: start ------- 21:52:27 INFO - PROCESS | 23030 | Number of tests: 14 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 21:52:27 INFO - PROCESS | 23030 | Values: 112.0 114.0 113.0 112.0 113.0 113.0 114.0 114.0 113.0 113.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:133.50 stddev:18.80 (14.1%) stddev-sans-first:19.13 21:52:27 INFO - PROCESS | 23030 | Values: 156.0 125.0 132.0 179.0 130.0 128.0 127.0 134.0 165.0 133.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 21:52:27 INFO - PROCESS | 23030 | Values: 161.0 161.0 162.0 162.0 162.0 161.0 162.0 162.0 162.0 161.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#3] audio-fft Cycles:10 Average:85.20 Median:77.00 stddev:15.89 (20.6%) stddev-sans-first:16.50 21:52:27 INFO - PROCESS | 23030 | Values: 76.0 85.0 76.0 120.0 78.0 78.0 78.0 76.0 109.0 76.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.50 stddev:15.68 (18.8%) stddev-sans-first:16.33 21:52:27 INFO - PROCESS | 23030 | Values: 85.0 83.0 113.0 83.0 85.0 84.0 114.0 84.0 83.0 121.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:52:27 INFO - PROCESS | 23030 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:52:27 INFO - PROCESS | 23030 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:52:27 INFO - PROCESS | 23030 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.17 21:52:27 INFO - PROCESS | 23030 | Values: 64.0 63.0 62.0 63.0 65.0 64.0 63.0 65.0 65.0 65.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 21:52:27 INFO - PROCESS | 23030 | Values: 65.0 66.0 65.0 66.0 67.0 65.0 65.0 66.0 65.0 66.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.20 (2.7%) stddev-sans-first:2.29 21:52:27 INFO - PROCESS | 23030 | Values: 82.0 84.0 89.0 82.0 83.0 83.0 83.0 83.0 81.0 82.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:146.50 stddev:12.67 (8.7%) stddev-sans-first:13.44 21:52:27 INFO - PROCESS | 23030 | Values: 147.0 141.0 142.0 151.0 138.0 146.0 140.0 138.0 181.0 148.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:176.50 stddev:1.97 (1.1%) stddev-sans-first:2.06 21:52:27 INFO - PROCESS | 23030 | Values: 177.0 175.0 177.0 175.0 176.0 179.0 176.0 173.0 174.0 179.0 21:52:27 INFO - PROCESS | 23030 | 21:52:27 INFO - PROCESS | 23030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 21:52:27 INFO - PROCESS | 23030 | Values: 70.0 71.0 70.0 74.0 70.0 72.0 70.0 70.0 69.0 68.0 21:52:27 INFO - PROCESS | 23030 | -------- Summary: end -------- 21:52:27 INFO - PROCESS | 23030 | 21:52:28 INFO - TEST-INFO | 23030: exit 0 21:52:28 INFO - TEST-OK | kraken | took 64464ms 21:52:28 INFO - SUITE-END | took 1186s 21:52:28 INFO - Completed test suite (00:19:46) 21:52:28 INFO - javascript benchmark 21:52:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2515.157422263542, 2538.42885350796, 2561.2444328922966, 2578.0461229345146, 2581.4449893272945, 4478.193925093482, 4530.161920044794, 4537.591616754491, 4555.08898220356, 4559.4528656561215, 4580.519045500225, 4588.311753237016, 4591.793369298382, 4602.171609110359, 4605.332226827108, 4188.078622703, 4211.915761684764, 4219.409282700424, 4247.235497610429, 4283.978580107095, 4184.3305071188615, 4284.67864910133, 4288.292431748758, 4297.484301883778, 4299.441072660566, 4226.682998775089, 4244.533101358848, 4260.211860805761, 4263.850765223217, 4275.380069889879, 4317.028668549583, 4319.524852266248, 4321.351797230409, 4338.58783415575, 4344.674149438789, 4121.1345617420375, 4157.833686652531, 4159.209750147493, 4215.662746980265, 4292.635126014293, 4568.063546972862, 4581.885452863672, 4591.862244132682, 4602.033572949685, 4617.538246175355, 4949.059678661043, 4950.183219768734, 4953.479884612136, 5001.299818025479, 5031.748412579356, 4818.951810481885, 4897.485763994765, 4997.30037794709, 5006.8497945061345, 5049.141645920203, 4533.184026875161, 4546.52261512543, 4561.908761824745, 4579.702319349231, 4644.7213167210075, 4985.853253751585, 4987.0, 4989.101961646866, 4995.150824359867, 5046.84859454217, 4673.95326046742, 4784.617230621542, 4785.641076919245, 4799.3760811094335, 4859.368282123372, 4814.518548145157, 4880.219164933665, 4948.505149485095, 4949.851504454872, 5019.121653710586, 4909.705417674951, 4916.852494425173, 4917.385326834145, 4929.7781599828095, 4982.128127577659, 4758.857234282977, 4887.0, 4905.509449055137, 4906.1414252505665, 4963.0, 4106.117184805281, 4109.794510274474, 4120.958790412117, 4138.503379594468, 4151.56408577095, 3614.4216925291826, 3627.510286111394, 3661.9816900915325, 3663.6336366363153, 3673.3755261605593, 4281.293586558245, 4283.357496375568, 4283.87148385549, 4284.485861696554, 4338.110687309094, 4803.975980120077, 4850.369451971292, 4850.975745121252, 4934.432540257844, 4978.551930326288, 4370.672199585044, 4392.538783427758, 4395.604395604411, 4405.383246345515, 4408.713433626804, 4481.865544033684, 4489.663275254369, 4495.43807024122, 4499.955000450019, 4517.954820451819, 4706.835260765857, 4712.175369310288, 4713.2458806590785, 4715.952840471551, 4772.331873537777, 4795.832145874878, 4845.75771211445, 4937.234728616926, 4976.626752993468, 4978.8755281118265, 4714.5992590630185, 4724.71651700899, 4732.858014259577, 4770.332153498443, 4775.331453596569, 4909.140900342497, 4920.1389756791705, 4921.63087768426, 4922.778474968707, 4982.302477653204, 4843.564079232886, 4863.197572400514, 4882.389701287339, 4884.0476107158765, 4987.07739068259, 4734.668573199843, 4769.809207631656, 4772.809087636595, 4810.436608102451, 4825.396825396825, 4766.394771633227, 4771.212749896228, 4773.331733557374, 4774.737389443475, 4819.759012049453, 4534.6599005074095, 4663.626909847137, 4669.4396672399525, 4676.532346765296, 4735.479097299225, 4817.012512434872, 4830.2996065571, 4834.854954351375, 4839.854804355875, 4840.104580652591, 4717.69334993238, 4734.242521196592, 4740.312654665123, 4797.016611594545, 4802.807887684454], "value": 4527.7460278619155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.5937528103362, 530.1438177343591, 546.6556069676103, 561.4666067236125, 564.2664536103066, 26784.196474105785, 36643.0, 37623.99999999996, 37642.24715505688, 41793.0, 39347.83586902719, 39820.20359592806, 39823.80088099556, 39830.40254396186, 39832.20335593286, 7569.545827250355, 7710.691572337099, 7711.4216433767415, 7711.5758633275145, 7713.1515533291295, 7650.885236721454, 7749.380049596019, 7760.146383897795, 7761.922380776176, 7764.534127952313, 7737.613119344011, 7759.728409505668, 7775.30022297993, 7779.611019449005, 7784.961075194645, 7627.923720762805, 7728.536287822721, 7745.883811742829, 7751.984484034192, 7753.302202801775, 7621.771346859603, 7698.114716807583, 7700.3069723724575, 7703.807404814925, 7704.229577042307, 35960.64039359625, 36095.81952090249, 36158.276834463424, 36177.0, 36194.276114477565, 2568.8844002019955, 2673.4786716590274, 2703.2836298380944, 2966.036038287565, 3211.341674956628, 27367.452650947067, 27505.587416188773, 27622.856571514432, 28265.293367665767, 28361.290967725767, 3415.5389022481895, 3438.2607739335913, 3485.8082805445692, 3566.1262990567216, 3573.0352804742574, 228344.0, 229021.0, 229155.0, 229738.0, 231274.0, 48277.51722482801, 48982.26526602104, 49239.0, 49271.50728492741, 49586.50413495819, 51210.74394628003, 51247.74376128095, 51259.77324081626, 51305.0, 51306.23040654393, 14110.365033573515, 14902.627434314229, 14977.251137443085, 14987.32557034936, 15360.923195384175, 11192.0, 11346.886531134747, 11352.580927384077, 11357.545698172145, 11384.48769805344, 17338.566535836453, 17341.7398739019, 17357.47927562175, 17358.91320543389, 17491.737623935653, 6636.170478690164, 6656.70044847983, 6658.201015878126, 6704.3295670433545, 6917.377436030782, 754.4907187648315, 790.8734602463693, 876.3339861705023, 882.7660669922476, 933.869258303838, 26029.73970260311, 27256.86371568169, 27843.721562784518, 27862.164135075982, 27900.0, 761.9276168763959, 936.4053825820653, 950.1686024728363, 953.2659851914126, 990.895955924632, 13293.301480746455, 14178.291085445686, 14414.711705765825, 14649.267536623127, 14655.706885862222, 338005.0, 342525.0, 343155.0, 343314.0, 343374.0, 47273.0, 47593.286100708516, 47654.5234547657, 47728.0, 47773.28340074902, 1026.4559783314855, 1072.9678109656722, 1083.5774048121398, 1135.5457816873318, 1168.2348062019391, 25254.74745252524, 28048.579271311355, 29733.256668583457, 30836.383272334875, 31080.533791992686, 45418.09163816639, 45968.31047534223, 45999.77000115112, 46005.76997114993, 46040.53959460497, 307944.0, 312276.0, 312448.0, 313429.0, 313913.0, 24250.63624045676, 24682.50634987326, 25017.0, 25144.11419143535, 25175.0, 38632.42051369288, 39194.412083819334, 39846.0, 40125.59874401218, 40193.0, 33682.49476257809, 34117.80587679419, 34155.316893662486, 34417.82791086029, 34775.478367824, 34462.0, 34485.58600897913, 34895.82552087223, 34911.82544087365, 34989.30021399609, 27846.0, 33646.32707345888, 34550.0, 34589.0, 37602.24795504129, 29969.400611988076, 31805.522917156723, 32334.676653233168, 32500.674993249766, 32507.837460812545, 24600.443260203272, 24876.0, 24997.75002250027, 25195.0, 25472.235832925042], "value": 16932.78774051814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.92560025194837, 365.2366553902344, 366.16697014292487, 382.0963421508131, 383.24500733554885, 16051.759223611654, 16128.0, 16623.91688041558, 16707.331706731748, 16721.83278167218, 14633.268336583182, 15746.606334841636, 16306.918465407685, 16428.260728267225, 16438.095904725236, 4858.635602329813, 5129.153689641204, 5130.2817605535065, 5132.692038477685, 5138.22926561017, 3648.1244501319625, 3835.175437280984, 3840.7695538267794, 3888.988862895639, 5029.094762942669, 3875.4961854958815, 3879.9612003880025, 3901.4668920627164, 6021.45806877381, 6051.152838602599, 5780.364159942403, 5826.883462330751, 5982.162497250389, 5982.730777115018, 5988.31134419543, 5150.175971844487, 5176.482351764794, 5182.663126896739, 5184.092783762864, 5185.351831021122, 16472.176391180394, 16599.0, 17712.114394280234, 18472.261109555602, 18602.162902669414, 1771.7873855137336, 1803.7023891057959, 1931.0563373307893, 2096.7693553709078, 2363.5981883079917, 9046.592903319366, 9259.30555208362, 11721.589744358907, 11952.581659641957, 13182.077254592183, 1607.8794090443146, 1628.9266982985794, 1746.9650606987916, 1751.903645299508, 1756.7540544323806, 54856.177157342674, 62066.68966655138, 62762.0, 68382.31617683859, 70210.2978970214, 9397.765055873659, 9520.952395237979, 9560.808783824423, 9726.951365243129, 9900.851487227697, 13325.73348533024, 13327.400266988008, 13342.19946803195, 13343.466261349631, 13371.264580448169, 6950.54821436605, 7030.6484675766005, 7152.213256541776, 7214.92785072153, 7260.745873894494, 6743.758030350454, 6756.391924726799, 6887.2079710832895, 6962.443004559623, 6984.2317345092, 4054.878353649395, 4092.6725861930972, 4135.648469880034, 4177.519585247735, 4210.136921930997, 1730.3597668862349, 1738.582740142382, 1769.0638329716535, 1814.7277908313858, 1818.2545156485778, 781.3709963479454, 823.8887750153652, 830.5390508267969, 882.6116508736136, 901.3960646366819, 15036.398544058335, 15986.76019859703, 16014.359425622844, 16486.75269870953, 16876.409325673543, 831.2352635575164, 832.6835802395051, 842.1914961636897, 853.7225401744458, 876.9561521923878, 8885.733427997171, 9170.724878253663, 9363.812723745486, 9490.762730931781, 9636.662716804878, 266003.0, 266825.0, 267094.0, 359154.0, 363860.0, 74576.0, 77736.0, 77825.0, 78810.60594697105, 79539.60230198812, 885.1104639836923, 891.1266958380824, 912.1927094521396, 921.2629896083107, 926.4395041000232, 14538.0, 14809.481668141563, 15075.54773356801, 15259.389624414898, 15421.768673469682, 36127.45808812817, 36177.819110904275, 36458.63541364553, 36741.22364092651, 37489.625103749706, 48863.5113648859, 49068.263976041104, 49136.50863491462, 49241.0, 49347.25979110244, 6580.76967306142, 7382.630868456663, 7397.963010184914, 7498.512596681198, 7982.042154941212, 8176.918230817616, 10576.788464230825, 11476.713082172679, 11498.310101393943, 11622.0, 10116.443595602312, 10205.438700871226, 10374.066334029974, 10478.842817357898, 10549.419781912069, 9870.259730520096, 10231.641892533726, 10426.947865260625, 10495.422751748727, 10538.736531586772, 9930.205583553443, 9934.751631209278, 10013.19894408431, 10104.949475252577, 10283.12593429567, 7563.205863384265, 7712.768616941501, 7758.4181186410115, 7902.407319450949, 7960.522368657899, 9018.909810901807, 9385.953070234878, 9840.409575425498, 9965.451900145561, 9980.750481238027], "value": 7914.877763016935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.34476038179, 1314.0407502523158, 1338.250579675382, 1374.5395292576986, 1641.2450272874478, 6338.524610654202, 7077.646117694114, 7350.963245183767, 7357.852842943144, 7537.773866783991, 7367.631618419085, 7426.368758655521, 7428.851422971537, 7433.219511951235, 7439.888401673979, 1849.9075046247667, 1858.1731129647312, 1858.804825493324, 1865.4123950955407, 1867.5144462439796, 1842.3643842874187, 1883.9811601883944, 1884.5194475408753, 1889.0177107903883, 1890.7447494588191, 1797.263122119931, 1812.9093545322746, 1816.6094289727705, 1817.2549254805533, 1820.1263393571028, 1753.403842693484, 1819.5360183153343, 1821.4608655685925, 1822.0889555222388, 1824.6624374490762, 1760.9735853962202, 1799.8290162434548, 1802.7295905614133, 1803.9819601803945, 1806.665766833127, 7184.928150718531, 7293.343599076055, 7321.963390183068, 7359.337659610661, 7359.963200184018, 4262.829486820523, 4443.822247110112, 4462.977685111586, 4463.0, 4465.531119232466, 2643.193825883105, 2782.8886844526196, 2796.049343223314, 2826.053272153831, 2835.8723857426257, 904.7150147703518, 908.8330006918287, 929.2937367600672, 931.7903471718809, 940.1397721085199, 9900.405975641484, 9971.90028099717, 10012.0, 10018.799624007479, 10019.048190421898, 3501.439769636846, 3567.8572857085946, 3650.452432135201, 3711.2948539777894, 3729.8321575529167, 7984.08183058944, 7993.040835099825, 7996.0, 7997.800054998672, 8001.759947201594, 4297.914041719148, 4300.204462174508, 4301.935470967938, 4303.548127446573, 4307.203167413976, 3422.1102513346214, 3551.5383000210322, 3978.602139785998, 3995.2409042281874, 4001.3197756381487, 3049.618797650294, 3063.9540406893916, 3176.2377029513214, 3201.6798320168264, 3205.743540516753, 973.756560859785, 978.6232300564334, 984.7931934293879, 986.4229425785852, 995.7809281957958, 695.3012222716138, 721.8953251778463, 733.4205977277891, 745.198911170494, 751.9661615227328, 4802.351682522814, 4816.590589799836, 4927.975360123177, 4990.226514890198, 5070.974645126825, 796.482286513759, 843.8185790055045, 885.154677283193, 900.243795212025, 935.050923312838, 3316.7512436567354, 3413.8293085345636, 3423.5549378580627, 3441.6558344165883, 3481.3559491493647, 8566.742997710078, 8907.465552066897, 8914.643414263486, 8933.374663773604, 8934.910650893538, 8857.601407936529, 8881.911180888237, 8886.644534218689, 8903.287736981027, 8915.643374264957, 6811.863762724817, 6812.727490900407, 6977.720891164398, 6991.510594258353, 7000.264972177848, 4726.432828060655, 4792.257200133985, 4866.075445665312, 4866.853994380032, 5082.339295891658, 8034.718784842503, 8171.877421838558, 8196.30331421812, 8255.669773209005, 8349.373796965374, 8342.0, 8421.368397370099, 8468.153184681729, 8468.280196183394, 8491.490510569385, 5874.265716785402, 5970.701464926823, 5974.6713930732485, 5979.133025711334, 5979.760809567742, 6769.898451523132, 6980.232174460703, 7003.3346832050875, 7182.748603798842, 7183.20984691673, 6202.875942481215, 6277.717502712298, 6301.779437719658, 6385.489160867212, 6544.8363790905605, 6065.939340606714, 6144.8771024580155, 6149.7847575334645, 6205.968970155121, 6310.148130002391, 5710.486056254957, 5816.47651711348, 5826.300843898759, 5851.063829787214, 5859.326177489644, 4083.285425050664, 4119.443875076826, 4175.87472375817, 4191.392248124066, 4211.852585159505, 4445.133199026288, 4453.398791163151, 4502.57225563571, 4518.118966801442, 4664.696794708333], "value": 3783.0173279210208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.9247010836966, 270.27963546900446, 276.34092688936903, 277.3869747857234, 280.5917390197263, 4359.237133501632, 4592.807998441085, 4812.831550895715, 4836.17784976554, 4844.128056949743, 4653.488116307212, 4746.24060150376, 4750.9072913229975, 4757.430048084133, 4769.427668679755, 3743.382341913581, 3751.8311675974646, 3760.717946154036, 3766.6986641068647, 3767.491388662537, 3471.6701913318193, 3600.207954250061, 3611.1694310308644, 3703.925921481569, 3731.75743576668, 3664.413693808991, 3682.576503702082, 3684.1894783147663, 3685.4287585424304, 3686.3548878946076, 3672.7429079964413, 3682.355587772129, 3690.7785532868115, 3695.5195824542907, 3699.5375578052744, 3036.5748795168693, 3226.6934641209045, 3234.91912702182, 3246.6428692844006, 3250.1874531367157, 4619.030003699228, 4646.256598944153, 4664.440267167927, 4664.510226426244, 4671.85984420468, 4177.248095342868, 4182.1008483176265, 4187.623113919732, 4189.49726032878, 4190.958090419087, 4789.616830653539, 4946.87632809179, 4972.477889821553, 5007.824726134568, 5012.799488020475, 3454.758166928316, 3457.11843479911, 3459.9481007784902, 3465.462853257749, 3473.2532505511185, 5010.599152067826, 5207.817726379596, 5252.343457067866, 5267.947320526822, 5275.28783614211, 3391.1522119470133, 3414.6585341466152, 3476.269983303484, 3506.4389697648253, 3507.4037413639744, 3523.982380088083, 3553.911152221215, 3553.9466907996402, 3555.3690269201124, 3563.1448452371765, 4119.073208528117, 4121.258173528734, 4126.071633882352, 4130.442390277334, 4135.648469880094, 4832.9275060874115, 4983.6013118950395, 5013.8718788272345, 5026.371703537058, 5033.622478314068, 1211.3761412872377, 1220.6094049904123, 1223.9265644061384, 1224.5163160551533, 1232.6363722701824, 758.3440324119707, 773.4972268025716, 790.2334735306744, 790.920907909216, 796.6693822063894, 3986.8405263789705, 3997.0621593129026, 3999.800159872149, 4005.379166229239, 4012.558618551957, 4529.84145554904, 4535.752668016322, 4555.33947577606, 4559.4072770539615, 4602.539746025371, 3956.5647778744315, 4042.2521833460905, 4054.5134583849535, 4069.7965101744794, 4089.3252613319064, 2268.4895898422724, 2408.879556022227, 2421.32202983165, 2427.490227052339, 2441.5727247731575, 4296.3555466680245, 4300.741955482681, 4341.869743907688, 4354.303311470149, 4356.1921802451625, 4650.395448591661, 4662.510436404196, 4668.8132474701315, 4678.836240731558, 4684.641453978376, 4082.4692789937117, 4277.422547956111, 4305.6986010978935, 4311.030018245932, 4313.547077556811, 4514.88712782183, 4536.8638940831825, 4543.341215523797, 4567.337736028324, 4576.244919588231, 4443.600075993176, 4510.188166130128, 4512.691319517435, 4535.3650488932235, 4547.136044151601, 4068.2099876055627, 4318.0, 4356.49900261474, 4357.651387888898, 4365.388845561687, 3261.5433839262046, 3263.3473305339503, 3267.460868956691, 3291.753118516073, 3308.801471911693, 4534.274516077412, 4562.0, 4566.725996440225, 4579.381783459324, 4612.907741845212, 4407.801648925742, 4441.911161776811, 4453.955460445483, 4466.865994020184, 4482.641388688832, 4378.124375125051, 4576.58810707038, 5007.9733654599995, 5049.2426136079885, 5054.873628159178, 4936.851894443173, 4941.407031156285, 4942.92585611209, 4943.975280123576, 4944.0, 5111.769970351269, 5124.256982737407, 5132.384113906355, 5141.971605678805, 5149.124648809786, 4854.854354369375, 4941.777620007037, 4956.454789973172, 4977.481868030285, 4983.327250821238], "value": 3573.457136442035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2479438304927, 603.4237303375277, 628.3779058731857, 671.6507416143605, 714.7391202211195, 12263.386830658465, 13427.798583021238, 13446.126001809887, 13456.730865382686, 13467.730645387086, 13051.347432628378, 13143.737125257512, 13179.60461186166, 13180.0, 13181.20912745236, 588.1060787602842, 605.2887856768301, 740.7222291640621, 744.6128013433039, 755.8374949385881, 746.8319628083665, 750.0961341583379, 750.2235186581889, 750.3059669805408, 751.3538357012992, 793.9603019849013, 796.2356138107394, 796.4584082823677, 797.6889013284795, 797.996010019949, 609.5276160975258, 627.438442593876, 628.4249911331173, 629.3360504667573, 791.0981481111509, 467.3247157856898, 570.361195461082, 585.1749033862234, 586.7652938824505, 587.7913340764053, 12949.287789171593, 12955.935220323838, 12997.610071697864, 12997.610071697864, 13002.219866808022, 11754.706132346675, 12272.877271227262, 12610.684732881751, 12777.616671499869, 12841.0, 11009.28439651428, 11174.776504469864, 11202.66392008241, 11260.718482037933, 11365.829512557319, 4027.254957832781, 4056.7565946043333, 4066.63400293972, 4073.6130067643526, 4094.2016306820183, 57632.71183644097, 57664.42335576675, 57681.0, 57730.422695772926, 58501.122483162784, 9330.30022748283, 9340.766480838034, 9489.145976862115, 9569.473678947585, 9905.207583393456, 17395.304187832597, 17716.0, 17751.644967100845, 17771.555711107325, 17801.910990445223, 6438.935610643927, 6450.161479007793, 6483.481321494269, 6580.8354791130605, 6618.0, 3528.4530897710897, 3550.1302180965827, 3569.6430356964615, 3576.8926932192076, 3578.1949061460964, 2661.467706458716, 2773.1541879726474, 2777.4306267215175, 2779.2634951737805, 3024.7882648214854, 520.4327283261264, 520.6537652461146, 524.090702630935, 526.6945171800346, 535.1651423778917, 462.17732436263503, 549.5658429840461, 567.8026039228213, 576.9153990497837, 628.9748410063546, 7922.524648521107, 8031.759047228593, 8060.717874874351, 8196.877046844302, 8268.586570671443, 554.6810583914184, 559.6166625861298, 571.5798887817451, 571.6198727846019, 585.6193474241777, 3716.758410703296, 3846.5961074087377, 4051.8379264829077, 4108.8356465741035, 4159.376093585925, 97442.51278743702, 99789.50105249428, 101367.49316253519, 104142.0, 104225.0, 83457.58271208605, 85468.0, 87728.56135719281, 89400.55299723589, 90116.0, 77646.0, 77818.61090694624, 78435.2156478428, 78450.0, 79210.6039469799, 7649.426293027934, 7892.684292628231, 7991.960040199761, 8161.183881612029, 8205.138460461805, 39841.0, 45274.54725452703, 46683.76658116688, 47148.764256178496, 47156.0, 61450.38549614626, 63869.36130638634, 66671.66664166648, 67503.3249667497, 70189.64905175442, 9256.166944974984, 9622.13400793932, 9627.951860240933, 9698.321117521988, 9758.170555502578, 11153.0, 11166.888331116585, 11269.830952535882, 11421.257618254787, 11979.221350612183, 9831.115199632068, 10118.49407529606, 10459.738506537398, 10483.274348669249, 10520.894791051991, 10359.689209323733, 10409.0, 10489.947550262199, 10701.090407315465, 10998.835017474905, 9965.800683986135, 10130.696079117639, 10165.949170254102, 10695.090917272119, 10696.251262411868, 8192.426530143071, 8442.574257425742, 8451.197136272045, 8507.300108927158, 8835.779105522413, 8578.785530361542, 8775.780605484913, 8953.238974687225, 9054.637814487347, 9425.0], "value": 6316.59173360216, "unit": "score"}], "name": "dromaeo_css", "value": 6105.949386422734, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 112.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 132.0, 179.0, 130.0, 128.0, 127.0, 134.0, 165.0, 133.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 76.0, 120.0, 78.0, 78.0, 78.0, 76.0, 109.0, 76.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 113.0, 83.0, 85.0, 84.0, 114.0, 84.0, 83.0, 121.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 65.0, 64.0, 63.0, 65.0, 65.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 89.0, 82.0, 83.0, 83.0, 83.0, 83.0, 81.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 142.0, 151.0, 138.0, 146.0, 140.0, 138.0, 181.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 177.0, 175.0, 176.0, 179.0, 176.0, 173.0, 174.0, 179.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 74.0, 70.0, 72.0, 70.0, 70.0, 69.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1558.3999999999999, "alertThreshold": 2.0}]} 21:52:28 INFO - Return code: 0 21:52:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:52:29 INFO - # TBPL SUCCESS # 21:52:29 INFO - Running post-action listener: _resource_record_post_action 21:52:29 INFO - [mozharness: 2016-10-07 04:52:29.017093Z] Finished run-tests step (success) 21:52:29 INFO - Running post-run listener: _resource_record_post_run 21:52:29 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392687616; Read time: 8; Write time: 230960 21:52:29 INFO - TinderboxPrint: CPU usage
13.1% 21:52:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:52:29 INFO - TinderboxPrint: I/O write bytes / time
392,687,616 / 230,960 21:52:29 INFO - TinderboxPrint: CPU idle
8,340.0 (86.9%) 21:52:29 INFO - TinderboxPrint: CPU user
1,209.2 (12.6%) 21:52:29 INFO - TinderboxPrint: Swap in / out
0 / 0 21:52:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99868672; Read time: 0; Write time: 79132 21:52:29 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292818944; Read time: 0; Write time: 151828 21:52:29 INFO - Running post-run listener: _upload_blobber_files 21:52:29 INFO - Blob upload gear active. 21:52:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:52:29 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 21:52:29 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:52:29 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:52:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:52:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:52:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:33 INFO - (blobuploader) - INFO - Done attempting. 21:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:52:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:34 INFO - (blobuploader) - INFO - Done attempting. 21:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:52:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:35 INFO - (blobuploader) - INFO - Done attempting. 21:52:35 INFO - (blobuploader) - INFO - Iteration through files over. 21:52:35 INFO - Return code: 0 21:52:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:52:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:52:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5b833a05ee6501c7528712be2f4269668fcf43958e455c4652fd8e6217e4a6e2bd4bd1eaedee14408eaae70dea8eb0301da0d2583afce363f48125576f12b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/afea273264f47908f499b21cce2d7c4e8c4645f9a223819c4801e6546a34b9974baeaf99780d34b97ef4e57976a2cadb5986406f80b07d23412075f73291ca20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09a6bb6bc2f4c52f3ae2618dff067a63cafdc51118367712f20fc9edc6cd732b2e936bae7f3b89872e16b2b8a8a86e6aa98e66abe9cbca6f63be221068f61039"} 21:52:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:52:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:52:35 INFO - Contents: 21:52:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5b833a05ee6501c7528712be2f4269668fcf43958e455c4652fd8e6217e4a6e2bd4bd1eaedee14408eaae70dea8eb0301da0d2583afce363f48125576f12b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/afea273264f47908f499b21cce2d7c4e8c4645f9a223819c4801e6546a34b9974baeaf99780d34b97ef4e57976a2cadb5986406f80b07d23412075f73291ca20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09a6bb6bc2f4c52f3ae2618dff067a63cafdc51118367712f20fc9edc6cd732b2e936bae7f3b89872e16b2b8a8a86e6aa98e66abe9cbca6f63be221068f61039"} 21:52:35 INFO - Running post-run listener: copy_logs_to_upload_dir 21:52:35 INFO - Copying logs to upload dir... 21:52:35 INFO - mkdir: /builds/slave/test/build/upload/logs 21:52:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.042325 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-06 21:52:34.791340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:52:34.795126) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f5b833a05ee6501c7528712be2f4269668fcf43958e455c4652fd8e6217e4a6e2bd4bd1eaedee14408eaae70dea8eb0301da0d2583afce363f48125576f12b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/afea273264f47908f499b21cce2d7c4e8c4645f9a223819c4801e6546a34b9974baeaf99780d34b97ef4e57976a2cadb5986406f80b07d23412075f73291ca20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09a6bb6bc2f4c52f3ae2618dff067a63cafdc51118367712f20fc9edc6cd732b2e936bae7f3b89872e16b2b8a8a86e6aa98e66abe9cbca6f63be221068f61039"} build_url:https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/RRV1IkBhS1K089Wq3IApWQ/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/Autoland-Non-PGO/sha512/f5b833a05ee6501c7528712be2f4269668fcf43958e455c4652fd8e6217e4a6e2bd4bd1eaedee14408eaae70dea8eb0301da0d2583afce363f48125576f12b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/afea273264f47908f499b21cce2d7c4e8c4645f9a223819c4801e6546a34b9974baeaf99780d34b97ef4e57976a2cadb5986406f80b07d23412075f73291ca20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09a6bb6bc2f4c52f3ae2618dff067a63cafdc51118367712f20fc9edc6cd732b2e936bae7f3b89872e16b2b8a8a86e6aa98e66abe9cbca6f63be221068f61039"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:52:34.820447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:52:34.820796) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475814135.122196-1128584971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:52:34.905581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:52:34.906006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:52:34.906356) ========= ========= Total master_lag: 0.36 =========