builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1475541156.01 results: success (0) buildid: 20161003153004 builduid: 798ba6ab12f040d0b378376817fb0f1b revision: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.009418) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.010296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.010905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.044379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.045188) ========= 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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 17:32:36-- 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% 9.34M=0.001s 2016-10-03 17:32:36 (9.34 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.144015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.144734) ========= 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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016457 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:36.198143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 17:32:36.198989) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 --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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 17:32:36,481 truncating revision to first 12 chars 2016-10-03 17:32:36,481 Setting DEBUG logging. 2016-10-03 17:32:36,481 attempt 1/10 2016-10-03 17:32:36,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8db4b1b5dfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 17:32:37,797 unpacking tar archive at: fx-team-8db4b1b5dfae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.696822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 17:32:37.914636) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:37.915387) ========= script_repo_revision: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:37.916366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:37.917089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 17:32:37.928892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 17:32:37.929577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:32:38 INFO - MultiFileLogger online at 20161003 17:32:38 in /builds/slave/test 17:32:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:32:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:38 INFO - {'append_to_log': False, 17:32:38 INFO - 'base_work_dir': '/builds/slave/test', 17:32:38 INFO - 'blob_upload_branch': 'Fx-Team', 17:32:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:38 INFO - 'branch': 'Fx-Team', 17:32:38 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:38 INFO - 'config_files': ('talos/linux_config.py',), 17:32:38 INFO - 'default_actions': ('clobber', 17:32:38 INFO - 'read-buildbot-config', 17:32:38 INFO - 'download-and-extract', 17:32:38 INFO - 'populate-webroot', 17:32:38 INFO - 'create-virtualenv', 17:32:38 INFO - 'install', 17:32:38 INFO - 'run-tests'), 17:32:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:38 INFO - 'download_minidump_stackwalk': True, 17:32:38 INFO - 'download_symbols': 'ondemand', 17:32:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:38 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:38 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:38 INFO - 'installer_path': 'installer.exe', 17:32:38 INFO - 'log_level': 'info', 17:32:38 INFO - 'log_name': 'talos', 17:32:38 INFO - 'log_to_console': True, 17:32:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:32:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:32:38 INFO - 'opt_config_files': (), 17:32:38 INFO - 'pip_index': False, 17:32:38 INFO - 'sps_profile': False, 17:32:38 INFO - 'sps_profile_interval': 0, 17:32:38 INFO - 'suite': 'dromaeojs', 17:32:38 INFO - 'system_bits': '32', 17:32:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:38 INFO - 'title': 'talos-linux64-ix-052', 17:32:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:38 INFO - 'use_talos_json': True, 17:32:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:38 INFO - 'work_dir': 'build'} 17:32:38 INFO - [mozharness: 2016-10-04 00:32:38.304666Z] Running clobber step. 17:32:38 INFO - Running pre-action listener: _resource_record_pre_action 17:32:38 INFO - Running main action method: clobber 17:32:38 INFO - rmtree: /builds/slave/test/build 17:32:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:32:38 INFO - Running post-action listener: _resource_record_post_action 17:32:38 INFO - [mozharness: 2016-10-04 00:32:38.766656Z] Finished clobber step (success) 17:32:38 INFO - [mozharness: 2016-10-04 00:32:38.766755Z] Running read-buildbot-config step. 17:32:38 INFO - Running pre-action listener: _resource_record_pre_action 17:32:38 INFO - Running main action method: read_buildbot_config 17:32:38 INFO - Using buildbot properties: 17:32:38 INFO - { 17:32:38 INFO - "project": "", 17:32:38 INFO - "product": "firefox", 17:32:38 INFO - "script_repo_revision": "production", 17:32:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:32:38 INFO - "repository": "", 17:32:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:32:38 INFO - "buildid": "20161003153004", 17:32:38 INFO - "pgo_build": "True", 17:32:38 INFO - "basedir": "/builds/slave/test", 17:32:38 INFO - "buildnumber": 1106, 17:32:38 INFO - "slavename": "talos-linux64-ix-052", 17:32:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:32:38 INFO - "platform": "ubuntu64_hw", 17:32:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:32:38 INFO - "branch": "fx-team", 17:32:38 INFO - "repo_path": "integration/fx-team", 17:32:38 INFO - "revision": "8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9", 17:32:38 INFO - "stage_platform": "linux64-pgo", 17:32:38 INFO - "builduid": "798ba6ab12f040d0b378376817fb0f1b", 17:32:38 INFO - "slavebuilddir": "test" 17:32:38 INFO - } 17:32:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:32:38 INFO - Running post-action listener: _resource_record_post_action 17:32:38 INFO - [mozharness: 2016-10-04 00:32:38.769184Z] Finished read-buildbot-config step (success) 17:32:38 INFO - [mozharness: 2016-10-04 00:32:38.769272Z] Running download-and-extract step. 17:32:38 INFO - Running pre-action listener: _resource_record_pre_action 17:32:38 INFO - Running main action method: download_and_extract 17:32:38 INFO - mkdir: /builds/slave/test/build/tests 17:32:38 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')]} 17:32:38 INFO - trying https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:32:38 INFO - Downloading https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/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 17:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/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 17:32:39 INFO - Downloaded 1361 bytes. 17:32:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:32:39 INFO - Using the following test package requirements: 17:32:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:32:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:32:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'jsshell-linux-x86_64.zip'], 17:32:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:32:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:32:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:32:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:32:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:32:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:32:39 INFO - Http code: 200 17:32:39 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 17:32:39 INFO - x-amz-cf-id: ckaJJMNRDWtyYx1JM5e7rbvHnFDTM_G2eoVQO1A31xqfGNRpvsHZTg== 17:32:39 INFO - x-amz-version-id: pF70w4VLhSh_qV36_6JX8eNoaBzvsHGO 17:32:40 INFO - Expected file size: 21991553 17:32:40 INFO - Obtained file size: 21991553 17:32:44 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 17:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:32:44 INFO - Http code: 200 17:32:44 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 17:32:44 INFO - x-amz-cf-id: nLpppQbSr2yyYQMrZY5hVDas-kyXCYOciy-9gFA72yU-y384K48Ijg== 17:32:44 INFO - x-amz-version-id: pF70w4VLhSh_qV36_6JX8eNoaBzvsHGO 17:32:45 INFO - Expected file size: 21991553 17:32:45 INFO - Obtained file size: 21991553 17:32:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:32:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:32:50 INFO - Http code: 200 17:32:50 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:32:50 INFO - x-amz-cf-id: oc4JDDpaSCmAinFcVmARCiCQF_dGM8GdIfOk6Kqf2aCkYlfawVpynw== 17:32:50 INFO - x-amz-version-id: tJZea1.1AcwG26iImFquUJdhmdbatM8a 17:32:50 INFO - Expected file size: 14409006 17:32:50 INFO - Obtained file size: 14409006 17:32:50 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')]} 17:32:50 INFO - trying https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:32:50 INFO - Downloading https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/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 17:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/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 17:32:51 INFO - Downloaded 59655454 bytes. 17:32:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:32:51 INFO - mkdir: /builds/slave/test/properties 17:32:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:32:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:32:51 INFO - Contents: 17:32:51 INFO - build_url:https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:32:52 INFO - Running post-action listener: _resource_record_post_action 17:32:52 INFO - Running post-action listener: set_extra_try_arguments 17:32:52 INFO - [mozharness: 2016-10-04 00:32:52.422286Z] Finished download-and-extract step (success) 17:32:52 INFO - [mozharness: 2016-10-04 00:32:52.422512Z] Running populate-webroot step. 17:32:52 INFO - Running pre-action listener: _resource_record_pre_action 17:32:52 INFO - Running main action method: populate_webroot 17:32:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:32:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:32:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:32:52 INFO - '--tppagecycles', 17:32:52 INFO - '7'], 17:32:52 INFO - 'tests': ['tsvgm']}}, 17:32:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:32:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:32:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:32:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:32:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['damp', 'tps']}, 17:32:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'tests': ['damp', 'tps']}, 17:32:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['dromaeo_dom']}, 17:32:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:32:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['basic_compositor_video']}, 17:32:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:32:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'other-e10s': {'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['a11yr', 17:32:52 INFO - 'ts_paint', 17:32:52 INFO - 'tpaint', 17:32:52 INFO - 'sessionrestore', 17:32:52 INFO - 'sessionrestore_no_auto_restore', 17:32:52 INFO - 'tabpaint']}, 17:32:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['tsvgx', 17:32:52 INFO - 'tsvgr_opacity', 17:32:52 INFO - 'tart', 17:32:52 INFO - 'tscrollx', 17:32:52 INFO - 'cart']}, 17:32:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:32:52 INFO - 'tsvgr_opacity', 17:32:52 INFO - 'tart', 17:32:52 INFO - 'tscrollx', 17:32:52 INFO - 'cart']}, 17:32:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'talos_options': ['--disable-e10s'], 17:32:52 INFO - 'tests': ['tp5o']}, 17:32:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'tests': ['tp5o']}, 17:32:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'talos_options': ['--disable-e10s', 17:32:52 INFO - '--xperf_path', 17:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:52 INFO - 'tests': ['tp5n']}, 17:32:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:52 INFO - 'talos_options': ['--xperf_path', 17:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:52 INFO - 'tests': ['tp5n']}}, 17:32:52 INFO - 'talos.zip': {'path': '', 17:32:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:32:52 INFO - Running post-action listener: _resource_record_post_action 17:32:52 INFO - [mozharness: 2016-10-04 00:32:52.443563Z] Finished populate-webroot step (success) 17:32:52 INFO - [mozharness: 2016-10-04 00:32:52.443651Z] Running create-virtualenv step. 17:32:52 INFO - Running pre-action listener: _resource_record_pre_action 17:32:52 INFO - Running main action method: create_virtualenv 17:32:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:32:52 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 17:32:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:32:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:32:52 INFO - Using real prefix '/usr' 17:32:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:32:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:32:55 INFO - Installing pip.................done. 17:32:55 INFO - Return code: 0 17:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:32:55 INFO - Reading from file tmpfile_stdout 17:32:55 INFO - Output received: 17:32:55 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) 17:32:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:32:55 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')]} 17:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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')]} 17:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:32:55 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 17:32:55 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 17:32:55 INFO - Using env: {'DISPLAY': ':0', 17:32:55 INFO - 'HOME': '/home/cltbld', 17:32:55 INFO - 'LANG': 'en_US.UTF-8', 17:32:55 INFO - 'LANGUAGE': 'en_US:en', 17:32:55 INFO - 'LOGNAME': 'cltbld', 17:32:55 INFO - 'MAIL': '/var/mail/cltbld', 17:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:55 INFO - 'MOZ_NO_REMOTE': '1', 17:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:55 INFO - 'NO_EM_RESTART': '1', 17:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:55 INFO - 'PWD': '/builds/slave/test', 17:32:55 INFO - 'SHELL': '/bin/bash', 17:32:55 INFO - 'SHLVL': '1', 17:32:55 INFO - 'TERM': 'linux', 17:32:55 INFO - 'TMOUT': '86400', 17:32:55 INFO - 'USER': 'cltbld', 17:32:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:55 INFO - '_': '/tools/buildbot/bin/python'} 17:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:55 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 17:32:55 INFO - Cleaning up... 17:32:55 INFO - Return code: 0 17:32:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:32:55 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')]} 17:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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')]} 17:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:32:55 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 17:32:55 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 17:32:55 INFO - Using env: {'DISPLAY': ':0', 17:32:55 INFO - 'HOME': '/home/cltbld', 17:32:55 INFO - 'LANG': 'en_US.UTF-8', 17:32:55 INFO - 'LANGUAGE': 'en_US:en', 17:32:55 INFO - 'LOGNAME': 'cltbld', 17:32:55 INFO - 'MAIL': '/var/mail/cltbld', 17:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:55 INFO - 'MOZ_NO_REMOTE': '1', 17:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:55 INFO - 'NO_EM_RESTART': '1', 17:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:55 INFO - 'PWD': '/builds/slave/test', 17:32:55 INFO - 'SHELL': '/bin/bash', 17:32:55 INFO - 'SHLVL': '1', 17:32:55 INFO - 'TERM': 'linux', 17:32:55 INFO - 'TMOUT': '86400', 17:32:55 INFO - 'USER': 'cltbld', 17:32:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:55 INFO - '_': '/tools/buildbot/bin/python'} 17:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:55 INFO - Downloading/unpacking psutil>=3.1.1 17:32:55 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 17:32:55 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 17:32:55 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 17:32:55 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 17:32:55 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 17:32:55 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 17:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:57 INFO - Installing collected packages: psutil 17:32:57 INFO - Running setup.py install for psutil 17:32:57 INFO - building 'psutil._psutil_linux' extension 17:32:57 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 17:32:57 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 17:32:57 INFO - building 'psutil._psutil_posix' extension 17:32:57 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 17:32:58 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 17:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:58 INFO - Successfully installed psutil 17:32:58 INFO - Cleaning up... 17:32:58 INFO - Return code: 0 17:32:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:32:58 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')]} 17:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:58 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')]} 17:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:58 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:32:58 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 17:32:58 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 17:32:58 INFO - Using env: {'DISPLAY': ':0', 17:32:58 INFO - 'HOME': '/home/cltbld', 17:32:58 INFO - 'LANG': 'en_US.UTF-8', 17:32:58 INFO - 'LANGUAGE': 'en_US:en', 17:32:58 INFO - 'LOGNAME': 'cltbld', 17:32:58 INFO - 'MAIL': '/var/mail/cltbld', 17:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:58 INFO - 'MOZ_NO_REMOTE': '1', 17:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:58 INFO - 'NO_EM_RESTART': '1', 17:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:58 INFO - 'PWD': '/builds/slave/test', 17:32:58 INFO - 'SHELL': '/bin/bash', 17:32:58 INFO - 'SHLVL': '1', 17:32:58 INFO - 'TERM': 'linux', 17:32:58 INFO - 'TMOUT': '86400', 17:32:58 INFO - 'USER': 'cltbld', 17:32:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:58 INFO - '_': '/tools/buildbot/bin/python'} 17:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:33:00 INFO - Installing collected packages: mozsystemmonitor 17:33:00 INFO - Running setup.py install for mozsystemmonitor 17:33:00 INFO - Successfully installed mozsystemmonitor 17:33:00 INFO - Cleaning up... 17:33:00 INFO - Return code: 0 17:33:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:33:00 INFO - Using env: {'DISPLAY': ':0', 17:33:00 INFO - 'HOME': '/home/cltbld', 17:33:00 INFO - 'LANG': 'en_US.UTF-8', 17:33:00 INFO - 'LANGUAGE': 'en_US:en', 17:33:00 INFO - 'LOGNAME': 'cltbld', 17:33:00 INFO - 'MAIL': '/var/mail/cltbld', 17:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:00 INFO - 'MOZ_NO_REMOTE': '1', 17:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:00 INFO - 'NO_EM_RESTART': '1', 17:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:00 INFO - 'PWD': '/builds/slave/test', 17:33:00 INFO - 'SHELL': '/bin/bash', 17:33:00 INFO - 'SHLVL': '1', 17:33:00 INFO - 'TERM': 'linux', 17:33:00 INFO - 'TMOUT': '86400', 17:33:00 INFO - 'USER': 'cltbld', 17:33:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:00 INFO - '_': '/tools/buildbot/bin/python'} 17:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:00 INFO - Downloading/unpacking jsonschema==2.5.1 17:33:00 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 17:33:00 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 17:33:00 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 17:33:00 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 17:33:00 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 17:33:00 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 17:33:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:33:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:33:02 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 17:33:02 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 17:33:02 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 17:33:02 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 17:33:02 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 17:33:02 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 17:33:02 INFO - Downloading functools32-3.2.3-2.tar.gz 17:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:33:02 INFO - warning: no files found matching '*.txt' 17:33:02 INFO - no previously-included directories found matching 'build' 17:33:02 INFO - no previously-included directories found matching 'dist' 17:33:02 INFO - no previously-included directories found matching '.git*' 17:33:02 INFO - Installing collected packages: jsonschema, functools32 17:33:02 INFO - Running setup.py install for functools32 17:33:03 INFO - warning: no files found matching '*.txt' 17:33:03 INFO - no previously-included directories found matching 'build' 17:33:03 INFO - no previously-included directories found matching 'dist' 17:33:03 INFO - no previously-included directories found matching '.git*' 17:33:03 INFO - Successfully installed jsonschema functools32 17:33:03 INFO - Cleaning up... 17:33:03 INFO - Return code: 0 17:33:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:33:03 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')]} 17:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:03 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')]} 17:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:03 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:03 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 17:33:03 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 17:33:03 INFO - Using env: {'DISPLAY': ':0', 17:33:03 INFO - 'HOME': '/home/cltbld', 17:33:03 INFO - 'LANG': 'en_US.UTF-8', 17:33:03 INFO - 'LANGUAGE': 'en_US:en', 17:33:03 INFO - 'LOGNAME': 'cltbld', 17:33:03 INFO - 'MAIL': '/var/mail/cltbld', 17:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:03 INFO - 'MOZ_NO_REMOTE': '1', 17:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:03 INFO - 'NO_EM_RESTART': '1', 17:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:03 INFO - 'PWD': '/builds/slave/test', 17:33:03 INFO - 'SHELL': '/bin/bash', 17:33:03 INFO - 'SHLVL': '1', 17:33:03 INFO - 'TERM': 'linux', 17:33:03 INFO - 'TMOUT': '86400', 17:33:03 INFO - 'USER': 'cltbld', 17:33:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:03 INFO - '_': '/tools/buildbot/bin/python'} 17:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:33:03 INFO - Cleaning up... 17:33:03 INFO - Return code: 0 17:33:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:33:03 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')]} 17:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:03 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')]} 17:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:03 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:03 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 17:33:03 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 17:33:03 INFO - Using env: {'DISPLAY': ':0', 17:33:03 INFO - 'HOME': '/home/cltbld', 17:33:03 INFO - 'LANG': 'en_US.UTF-8', 17:33:03 INFO - 'LANGUAGE': 'en_US:en', 17:33:03 INFO - 'LOGNAME': 'cltbld', 17:33:03 INFO - 'MAIL': '/var/mail/cltbld', 17:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:03 INFO - 'MOZ_NO_REMOTE': '1', 17:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:03 INFO - 'NO_EM_RESTART': '1', 17:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:03 INFO - 'PWD': '/builds/slave/test', 17:33:03 INFO - 'SHELL': '/bin/bash', 17:33:03 INFO - 'SHLVL': '1', 17:33:03 INFO - 'TERM': 'linux', 17:33:03 INFO - 'TMOUT': '86400', 17:33:03 INFO - 'USER': 'cltbld', 17:33:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:03 INFO - '_': '/tools/buildbot/bin/python'} 17:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:03 INFO - Downloading/unpacking blobuploader==1.2.4 17:33:03 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 17:33:03 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 17:33:03 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 17:33:03 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 17:33:03 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 17:33:03 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 17:33:05 INFO - Downloading blobuploader-1.2.4.tar.gz 17:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:33:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:33:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 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 17:33:06 INFO - Downloading docopt-0.6.1.tar.gz 17:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:33:06 INFO - Installing collected packages: blobuploader, requests, docopt 17:33:06 INFO - Running setup.py install for blobuploader 17:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:33:06 INFO - Running setup.py install for requests 17:33:06 INFO - Running setup.py install for docopt 17:33:06 INFO - Successfully installed blobuploader requests docopt 17:33:06 INFO - Cleaning up... 17:33:06 INFO - Return code: 0 17:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:06 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:06 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 17:33:06 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 17:33:06 INFO - Using env: {'DISPLAY': ':0', 17:33:06 INFO - 'HOME': '/home/cltbld', 17:33:06 INFO - 'LANG': 'en_US.UTF-8', 17:33:06 INFO - 'LANGUAGE': 'en_US:en', 17:33:06 INFO - 'LOGNAME': 'cltbld', 17:33:06 INFO - 'MAIL': '/var/mail/cltbld', 17:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:06 INFO - 'MOZ_NO_REMOTE': '1', 17:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:06 INFO - 'NO_EM_RESTART': '1', 17:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:06 INFO - 'PWD': '/builds/slave/test', 17:33:06 INFO - 'SHELL': '/bin/bash', 17:33:06 INFO - 'SHLVL': '1', 17:33:06 INFO - 'TERM': 'linux', 17:33:06 INFO - 'TMOUT': '86400', 17:33:06 INFO - 'USER': 'cltbld', 17:33:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:06 INFO - '_': '/tools/buildbot/bin/python'} 17:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:07 INFO - Running setup.py (path:/tmp/pip-fwGxK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:07 INFO - Running setup.py (path:/tmp/pip-CIPxFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:07 INFO - Running setup.py (path:/tmp/pip-A07BUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:07 INFO - Running setup.py (path:/tmp/pip-U1FDRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:07 INFO - Running setup.py (path:/tmp/pip-qYYQxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:07 INFO - Running setup.py (path:/tmp/pip-ATM8pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:07 INFO - Running setup.py (path:/tmp/pip-5PcZDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:07 INFO - Running setup.py (path:/tmp/pip-8P2Hhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:07 INFO - Running setup.py (path:/tmp/pip-VAaajW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:07 INFO - Running setup.py (path:/tmp/pip-AUxZFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:07 INFO - Running setup.py (path:/tmp/pip-Sm0v_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:07 INFO - Running setup.py (path:/tmp/pip-S3ZcaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:07 INFO - Running setup.py (path:/tmp/pip-zv0fCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:07 INFO - Running setup.py (path:/tmp/pip-cNRGek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:08 INFO - Running setup.py (path:/tmp/pip-NiVA4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:08 INFO - Running setup.py (path:/tmp/pip-JKKhZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:08 INFO - Running setup.py (path:/tmp/pip-B0hI5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:33:08 INFO - Running setup.py install for manifestparser 17:33:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:33:08 INFO - Running setup.py install for mozcrash 17:33:08 INFO - Running setup.py install for mozdebug 17:33:08 INFO - Running setup.py install for mozdevice 17:33:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:33:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:33:08 INFO - Running setup.py install for mozfile 17:33:08 INFO - Running setup.py install for mozhttpd 17:33:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:33:08 INFO - Running setup.py install for mozinfo 17:33:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:33:08 INFO - Running setup.py install for mozInstall 17:33:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Running setup.py install for mozleak 17:33:09 INFO - Running setup.py install for mozlog 17:33:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Running setup.py install for moznetwork 17:33:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Running setup.py install for mozprocess 17:33:09 INFO - Running setup.py install for mozprofile 17:33:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Running setup.py install for mozrunner 17:33:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:33:09 INFO - Running setup.py install for mozscreenshot 17:33:09 INFO - Running setup.py install for moztest 17:33:09 INFO - Running setup.py install for mozversion 17:33:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:33:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:33:10 INFO - Cleaning up... 17:33:10 INFO - Return code: 0 17:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:10 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')]} 17:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:10 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')]} 17:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:10 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:10 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 17:33:10 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 17:33:10 INFO - Using env: {'DISPLAY': ':0', 17:33:10 INFO - 'HOME': '/home/cltbld', 17:33:10 INFO - 'LANG': 'en_US.UTF-8', 17:33:10 INFO - 'LANGUAGE': 'en_US:en', 17:33:10 INFO - 'LOGNAME': 'cltbld', 17:33:10 INFO - 'MAIL': '/var/mail/cltbld', 17:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:10 INFO - 'MOZ_NO_REMOTE': '1', 17:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:10 INFO - 'NO_EM_RESTART': '1', 17:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:10 INFO - 'PWD': '/builds/slave/test', 17:33:10 INFO - 'SHELL': '/bin/bash', 17:33:10 INFO - 'SHLVL': '1', 17:33:10 INFO - 'TERM': 'linux', 17:33:10 INFO - 'TMOUT': '86400', 17:33:10 INFO - 'USER': 'cltbld', 17:33:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:10 INFO - '_': '/tools/buildbot/bin/python'} 17:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:10 INFO - Running setup.py (path:/tmp/pip-k1TQo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:10 INFO - Running setup.py (path:/tmp/pip-yahub1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:10 INFO - Running setup.py (path:/tmp/pip-9fVQ8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:10 INFO - Running setup.py (path:/tmp/pip-02ukY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:10 INFO - Running setup.py (path:/tmp/pip-H5GJfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:10 INFO - Running setup.py (path:/tmp/pip-HQvdzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:10 INFO - Running setup.py (path:/tmp/pip-rp9QZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:10 INFO - Running setup.py (path:/tmp/pip-zzL7y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:10 INFO - Running setup.py (path:/tmp/pip-Yr9qmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:10 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)) 17:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:10 INFO - Running setup.py (path:/tmp/pip-kOfvsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:11 INFO - Running setup.py (path:/tmp/pip-9_qoVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:11 INFO - Running setup.py (path:/tmp/pip-QTEgAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:11 INFO - Running setup.py (path:/tmp/pip-zL1CTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:11 INFO - Running setup.py (path:/tmp/pip-31CvKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:11 INFO - Running setup.py (path:/tmp/pip-09Gd5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:11 INFO - Running setup.py (path:/tmp/pip-dPzmH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:11 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)) 17:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:11 INFO - Running setup.py (path:/tmp/pip-87HHre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:11 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)) 17:33:11 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)) 17:33:11 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)) 17:33:11 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)) 17:33:11 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)) 17:33:11 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)) 17:33:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:33: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 17:33: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 17:33: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 17:33: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 17:33: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 17:33: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 17:33:13 INFO - Downloading blessings-1.6.tar.gz 17:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:33:13 INFO - Installing collected packages: blessings 17:33:13 INFO - Running setup.py install for blessings 17:33:13 INFO - Successfully installed blessings 17:33:13 INFO - Cleaning up... 17:33:13 INFO - Return code: 0 17:33:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:13 INFO - Reading from file tmpfile_stdout 17:33:13 INFO - Current package versions: 17:33:13 INFO - argparse == 1.2.1 17:33:13 INFO - blessings == 1.6 17:33:13 INFO - blobuploader == 1.2.4 17:33:13 INFO - docopt == 0.6.1 17:33:13 INFO - functools32 == 3.2.3-2 17:33:13 INFO - jsonschema == 2.5.1 17:33:13 INFO - manifestparser == 1.1 17:33:13 INFO - mozInstall == 1.12 17:33:13 INFO - mozcrash == 0.17 17:33:13 INFO - mozdebug == 0.1 17:33:13 INFO - mozdevice == 0.48 17:33:13 INFO - mozfile == 1.2 17:33:13 INFO - mozhttpd == 0.7 17:33:13 INFO - mozinfo == 0.9 17:33:13 INFO - mozleak == 0.1 17:33:13 INFO - mozlog == 3.4 17:33:13 INFO - moznetwork == 0.27 17:33:13 INFO - mozprocess == 0.23 17:33:13 INFO - mozprofile == 0.28 17:33:13 INFO - mozrunner == 6.12 17:33:13 INFO - mozscreenshot == 0.1 17:33:13 INFO - mozsystemmonitor == 0.3 17:33:13 INFO - moztest == 0.7 17:33:13 INFO - mozversion == 1.4 17:33:13 INFO - psutil == 3.1.1 17:33:13 INFO - requests == 1.2.3 17:33:13 INFO - wsgiref == 0.1.2 17:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:13 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')]} 17:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:13 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')]} 17:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:13 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 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33:13 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 17:33:13 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 17:33:13 INFO - Using env: {'DISPLAY': ':0', 17:33:13 INFO - 'HOME': '/home/cltbld', 17:33:13 INFO - 'LANG': 'en_US.UTF-8', 17:33:13 INFO - 'LANGUAGE': 'en_US:en', 17:33:13 INFO - 'LOGNAME': 'cltbld', 17:33:13 INFO - 'MAIL': '/var/mail/cltbld', 17:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:13 INFO - 'MOZ_NO_REMOTE': '1', 17:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:13 INFO - 'NO_EM_RESTART': '1', 17:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:13 INFO - 'PWD': '/builds/slave/test', 17:33:13 INFO - 'SHELL': '/bin/bash', 17:33:13 INFO - 'SHLVL': '1', 17:33:13 INFO - 'TERM': 'linux', 17:33:13 INFO - 'TMOUT': '86400', 17:33:13 INFO - 'USER': 'cltbld', 17:33:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:13 INFO - '_': '/tools/buildbot/bin/python'} 17:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 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)) 17:33:14 INFO - Cleaning up... 17:33:14 INFO - Return code: 0 17:33:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51c802df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a20790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, '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': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', '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 17:33: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', 'jsonschema'] in /builds/slave/test/build 17:33: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 jsonschema 17:33:14 INFO - Using env: {'DISPLAY': ':0', 17:33:14 INFO - 'HOME': '/home/cltbld', 17:33:14 INFO - 'LANG': 'en_US.UTF-8', 17:33:14 INFO - 'LANGUAGE': 'en_US:en', 17:33:14 INFO - 'LOGNAME': 'cltbld', 17:33:14 INFO - 'MAIL': '/var/mail/cltbld', 17:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:14 INFO - 'MOZ_NO_REMOTE': '1', 17:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:14 INFO - 'NO_EM_RESTART': '1', 17:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:14 INFO - 'PWD': '/builds/slave/test', 17:33:14 INFO - 'SHELL': '/bin/bash', 17:33:14 INFO - 'SHLVL': '1', 17:33:14 INFO - 'TERM': 'linux', 17:33:14 INFO - 'TMOUT': '86400', 17:33:14 INFO - 'USER': 'cltbld', 17:33:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:14 INFO - '_': '/tools/buildbot/bin/python'} 17:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:33:14 INFO - Cleaning up... 17:33:14 INFO - Return code: 0 17:33:14 INFO - Running post-action listener: _resource_record_post_action 17:33:14 INFO - Running post-action listener: _start_resource_monitoring 17:33:14 INFO - Starting resource monitoring. 17:33:14 INFO - [mozharness: 2016-10-04 00:33:14.399284Z] Finished create-virtualenv step (success) 17:33:14 INFO - [mozharness: 2016-10-04 00:33:14.399849Z] Running install step. 17:33:14 INFO - Running pre-action listener: _resource_record_pre_action 17:33:14 INFO - Running main action method: install 17:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:14 INFO - Reading from file tmpfile_stdout 17:33:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:33:14 INFO - Reading from file tmpfile_stdout 17:33:14 INFO - Output received: 17:33:14 INFO - Usage: mozinstall [options] installer 17:33:14 INFO - Options: 17:33:14 INFO - -h, --help show this help message and exit 17:33:14 INFO - -d DEST, --destination=DEST 17:33:14 INFO - Directory to install application into. [default: 17:33:14 INFO - "/builds/slave/test"] 17:33:14 INFO - --app=APP Application being installed. [default: firefox] 17:33:14 INFO - mkdir: /builds/slave/test/build/application 17:33:14 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'] 17:33:14 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 17:33:31 INFO - Reading from file tmpfile_stdout 17:33:31 INFO - Output received: 17:33:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:33:31 INFO - Running post-action listener: _resource_record_post_action 17:33:31 INFO - [mozharness: 2016-10-04 00:33:31.692845Z] Finished install step (success) 17:33:31 INFO - [mozharness: 2016-10-04 00:33:31.693090Z] Running run-tests step. 17:33:31 INFO - Running pre-action listener: _resource_record_pre_action 17:33:31 INFO - Running main action method: run_tests 17:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:33:31 INFO - Python 2.7.3 17:33:31 INFO - Return code: 0 17:33:31 INFO - grabbing minidump binary from tooltool 17:33:31 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')]} 17:33:31 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 0x2a1d930>, '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 0x2a1e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ecc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:33:31 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 17:33:31 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 17:33:31 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 17:33:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:33:31 INFO - Return code: 0 17:33:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:33:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:33:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:33:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:33:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 17:33:31 INFO - Using env: {'DISPLAY': ':0', 17:33:31 INFO - 'HOME': '/home/cltbld', 17:33:31 INFO - 'LANG': 'en_US.UTF-8', 17:33:31 INFO - 'LANGUAGE': 'en_US:en', 17:33:31 INFO - 'LOGNAME': 'cltbld', 17:33:31 INFO - 'MAIL': '/var/mail/cltbld', 17:33:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:31 INFO - 'MOZ_NO_REMOTE': '1', 17:33:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:31 INFO - 'NO_EM_RESTART': '1', 17:33:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:31 INFO - 'PWD': '/builds/slave/test', 17:33:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:31 INFO - 'SHELL': '/bin/bash', 17:33:31 INFO - 'SHLVL': '1', 17:33:31 INFO - 'TERM': 'linux', 17:33:31 INFO - 'TMOUT': '86400', 17:33:31 INFO - 'USER': 'cltbld', 17:33:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624', 17:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:31 INFO - '_': '/tools/buildbot/bin/python'} 17:33:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:33:31 INFO - mozversion application_buildid: 20161003153004 17:33:31 INFO - mozversion application_changeset: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 17:33:31 INFO - mozversion application_display_name: Nightly 17:33:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:33:31 INFO - mozversion application_name: Firefox 17:33:31 INFO - mozversion application_remotingname: firefox 17:33:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:33:31 INFO - mozversion application_vendor: Mozilla 17:33:31 INFO - mozversion application_version: 52.0a1 17:33:31 INFO - mozversion platform_buildid: 20161003153004 17:33:31 INFO - mozversion platform_changeset: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 17:33:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:33:31 INFO - mozversion platform_version: 52.0a1 17:33:31 INFO - using testdate: 1475541211 17:33:31 INFO - actual date: 1475541211 17:33:31 INFO - starting webserver on 'localhost:34059' 17:33:31 INFO - SUITE-START | Running 2 tests 17:33:31 INFO - TEST-START | dromaeo_css 17:33:31 INFO - operating with platform_type : linux_ 17:33:31 INFO - Initialising browser for dromaeo_css test... 17:33:31 INFO - TEST-INFO | started process 13679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTsniH/profile http://localhost:34059/getInfo.html) 17:33:36 INFO - PROCESS | 13679 | __metrics Screen width/height:1600/1200 17:33:36 INFO - PROCESS | 13679 | colorDepth:24 17:33:36 INFO - PROCESS | 13679 | Browser inner width/height: 1024/697 17:33:36 INFO - PROCESS | 13679 | __metrics 17:33:36 INFO - PROCESS | 13679 | 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" 17:33:36 INFO - PROCESS | 13679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:33:37 INFO - PROCESS | 13679 | console.error: PushService: 17:33:37 INFO - PROCESS | 13679 | stateChangeProcessEnqueue: Error transitioning state 17:33:37 INFO - PROCESS | 13679 | UnknownError 17:33:37 INFO - TEST-INFO | 13679: exit 0 17:33:37 INFO - Browser initialized. 17:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:37 INFO - TEST-INFO | started process 13762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTsniH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:49 INFO - PROCESS | 13762 | RSS: Main: 173318144 17:33:49 INFO - PROCESS | 13762 | 17:34:41 INFO - PROCESS | 13762 | 1475541281613 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] 17:36:51 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34059/tests/dromaeo/cssquery-ext.html) 17:36:53 INFO - PROCESS | 13762 | RSS: Main: 306319360 17:36:53 INFO - PROCESS | 13762 | 17:39:55 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-ext.html (next: http://localhost:34059/tests/dromaeo/cssquery-jquery.html) 17:39:56 INFO - PROCESS | 13762 | RSS: Main: 281567232 17:39:56 INFO - PROCESS | 13762 | 17:42:58 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34059/tests/dromaeo/cssquery-mootools.html) 17:42:59 INFO - PROCESS | 13762 | RSS: Main: 250249216 17:42:59 INFO - PROCESS | 13762 | 17:46:01 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34059/tests/dromaeo/cssquery-prototype.html) 17:46:01 INFO - PROCESS | 13762 | RSS: Main: 221454336 17:46:01 INFO - PROCESS | 13762 | 17:49:04 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34059/tests/dromaeo/cssquery-yui.html) 17:49:05 INFO - PROCESS | 13762 | RSS: Main: 219992064 17:49:05 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-yui.html (next: http://localhost:34059/tests/dromaeo/cssquery-dojo.html) 17:52:08 INFO - PROCESS | 13762 | RSS: Main: 313745408 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | __start_tp_report 17:52:08 INFO - PROCESS | 13762 | _x_x_mozilla_page_load 17:52:08 INFO - PROCESS | 13762 | _x_x_mozilla_page_load_details 17:52:08 INFO - PROCESS | 13762 | |i|pagename|runs| 17:52:08 INFO - PROCESS | 13762 | |0;dojo.html;3024.939501209976;3048.588440560525;3056.0678992907156;3086.4290106330345;3104.0998110547944;5162.070827251093;5267.051930652481;5277.604179686519;5315.123004704224;5338.652987555811;5199.14214154664;5260.842614624777;5296.232046353276;5340.759665815038;5391.406945236031;4726.291056341542;4752.881177970544;4753.33453316536;4758.952410475903;4877.6829506081995;4877.414710234777;4905.632077594177;4912.270219672974;4915.901681966358;4947.1589829728855;4654.790534425959;4693.859184224479;4778.307145463923;4857.319975203474;4884.389451318603;4804.231322988305;4815.446223684286;4873.537013983666;4887.584555312803;4889.682170658932;4754.310624959361;4774.045190961821;4781.545753153445;4794.712317260975;4850.975745121287;5113.386393632751;5247.86880327991;5253.3958594761325;5259;5314.654547454442;5481.945180548183;5572.721363931787;5597.3003374578175;5598.412166722476;5600.991821472134;5642.858928526779;5728.942710572883;5731.799387021434;5739.598228124033;5746.224259724925;5277.076511610491;5281.9471805281455;5284.841454756363;5285.656432331924;5287.339082614673;5719.554451764473;5762.88474230513;5791.160281759121;5793.217915581343;5860.267466566679;5354.41101478837;5390.19147127934;5499.972500137474;5503.477169668875;5558.666480011131;5563.332400112013;5578.330600327987;5581.804636837691;5583.944160558423;5642.322921249476;5483.643563168382;5547.417521160301;5554.72226388679;5555.916661250085;5565.833025009256;5403.135498320328;5404.567634589223;5464.3442786865835;5489.64317319373;5641.210230567724;4278.101598664253;4283.7429754214845;4329.891752706145;4331.155424692218;4343.3484977253665;3817.9427308590393;3824.3689791184697;3824.7513911595656;3868.4390763339156;3875.748076375027;5222.242774797709;5225.425203227642;5228.346456692913;5288.074586947346;5290.603204759658;5603.607747457639;5635.830925072254;5641.323041235078;5657.51911087554;5722.084466485426;5286.867828304323;5289.920651190235;5295.443978382292;5303.416624171338;5318.042752304622;4761.40482439695;4918.262260660929;4928.8767780805765;4937.679050861682;4975.527324904128;5637.943620563824;5747.597668163188;5812.389699081536;5828.242328497268;5928.3775203603;5638.693100933976;5683.3748287687495;5692.31692196939;5694.914576281442;5698.373178950229;5852.18069470266;5876.882462350643;5887.0580707086665;5890.116482527484;5890.381509941394;5388.299521062237;5392.379876314118;5416.808302173516;5424.2406063151975;5434.64674796137;5534.39121696605;5534.723263836872;5539.279893613804;5561.805336813192;5590.105583106846;5386.380566234933;5412.621116521806;5424.186372044225;5426.294581704353;5489.258950041693;5273.762680679302;5311.468853114658;5320.175372817064;5326.9200961984825;5391.110466773095;5319.335083114611;5321.36143662763;5322.38792538863;5323.893522129613;5326;5482.122860342485;5533.889322213614;5534.169874518854;5536.031194540858;5566.415526369673;5433.4566543345345;5438.6192966493545;5446.673199608036;5447.727613619382;5451.127819548853 17:52:08 INFO - PROCESS | 13762 | |1;ext.html;578.878435528539;596.9791057312995;610.6488768957851;617.4720613875133;642.4410762636506;31981;42631.78684106579;43413.78293108538;43584.12831743367;47285.29072063922;46223.76888115563;46406;46505;46566.534334656644;46748.766256168754;8906.554672266393;9025;9032.638694452215;9047.457152570867;9064.048274931103;8874.600642971049;8962.641494340218;8967.192952634261;8969.865452018224;8970.730878073635;8943.32925030622;8984.326175536828;8987.820243595124;8991.95504022479;8995.28037756978;8899.37704360695;8937.329700272441;8946.105389461067;8947.821043579157;8950.820983580357;8877.334199934967;8929.553522323922;8945.597448114786;8947.105289471066;8949.865752013726;42838;43094;43219.78390108029;43229.78385108086;43377.783111084245;3265.1020969233414;3597.928041439183;3829.9234015319817;4028.5568587455355;4130.0500884796365;32055.51916721251;32499.18752031218;32587.837060814545;32726.345473090405;32767.18082047968;4265.552117027699;4372.934405983913;4478.395416618748;4605.355250264965;4611.861644150681;358556.9999999974;360370.9999999974;361118;362063;362206;48928.75535622299;50308.245376319384;58228;58473.12290315649;59643;58169.41830581725;58424.12363814546;65605.34394656088;65988.67005665037;66199.33800662028;17336.826631733773;17561;17577.560560986076;17585.824141758676;17587.648247034987;11354.48904799286;12406.379681015913;12443.813342799865;12471.376431178405;12513.74972500545;16485.505434836974;19105.61788764217;19369.698886889782;20121.39635810928;20271.695924561143;7294.854102917912;7315.536892621497;7386.704531818667;7463.738769143054;7610.847783044308;910.3581974707815;931.9487428191379;1045.3727763342085;1066.5307264803462;1152.4468255237532;30304.84847575748;31762;31791;31864.68135318617;32363;1072.9248952573246;1076.6554702495127;1115.4088333183427;1123.5000424811044;1142.2803633710876;15669.60825979337;17016.659666806594;17028.744568831476;17031.48905532836;17297.65404691899;547607;550322;551540;552064;552225;59725.104123438185;59981;60055;60070.39929600735;60208.39791602115;1219.1100496637505;1237.7586370657634;1241.8944389726973;1248.7003119251497;1305.288617703373;30380.5442918352;33560.328793423505;34049.31901362009;34175.829120854236;34353.65646343504;50508.747456263955;51114.233286501476;51155.232671510705;51200.48799511957;51287;392086;393925;395161;395476;396428;28341.71658283391;29220.26949326199;29241.26896827511;29274.12177634589;30508.847455762578;47898.5210147894;48112.518874810805;48201;48472;49944.250836238214;40563;41123.38314925339;41423.37864931968;41916.16167676568;43339.56660433482;41148.79425602853;41286.58713412828;41483.58516414918;41992.144883265064;42162.36756448717;40920;41352.172956541304;41406.79296603498;41980.37029444622;42132;34664;36316.81841590775;37030;37286.6271337294;37623.43564846475;27535;27691.723082768913;28012;28060.579091314055;28133.71866281311 17:52:08 INFO - PROCESS | 13762 | |2;jquery.html;372.6683251905803;383.1035377217311;390.32278995942033;394.73552719677815;418.4497385937492;13644.931775341121;14833.035852669569;16726.16369181542;19413.417597472064;19509.609807803834;18512.81487185128;18647.906760466212;18780;18991.525211869677;19043.428697139072;5602.887942241153;5851.385604511529;5867.8533036674;5870.148828419877;5874.647521148745;4896.436909755388;6474.028895665664;6513.902291465632;6581.670916454182;6623.801285961405;6263;6409.198850143732;6584.275729669733;6590.2206404271055;6592.538522303416;6425.8393540161405;6449.806505804833;6475.773347932847;6486.318936511669;6486.675666216717;5560.888782224373;5647.943520564783;5784.1902133701315;5799.942000579982;5802.100674395433;22335.329940101823;22581.887090564443;22583.209587664518;22786.202482913017;22950.426239343982;2320.953580928389;2381;2397.412633904687;2423.9636405453934;2449.9632505512254;14044.297785110704;14178.716425671531;14183.78724319136;14439.205843678594;14468;1883.3973128598855;1884.8209420105204;1925.7207704882853;1961.6562654581514;2012.87922724637;81513.59243203746;82750;83473;83875;84034.15965840324;10512.474376281309;10644.520996555173;10877.510512026978;11440.885591144148;11747.647570572897;15437.922810385877;15439.614009649624;15487.922560387125;15499.5350139496;15525.84474155244;8257.339412846957;8398.958005209935;8421.536815475085;8565.271951884035;8615.39692221551;7920.287174154354;7933.325667318227;8018.158093400226;8277.461964972257;8292.04641466227;6485.416312531895;6501.609903405811;6579.17760279965;6615.966920165369;6660.733570657217;1834.4680042787443;1936.1384184037968;1944.134859987292;1951.1610007696827;1956.178405069874;885.4377470306273;964.3731574476506;976.2629214942815;1011.6610935336597;1037.0873631204493;18000.639987200182;18454.446366608754;18923.148458319407;18992.52518687044;19777.40667779969;1005.6832097889142;1054.8681414823147;1082.4533610526792;1107.1309022417363;1107.2083460325905;10281.635223898546;10916.945415272872;10942.671719848417;10950.780984380268;11027.22809403334;469680;479766;501364;507377;510403;84506;84860.57569712236;85028;85937;86551;990.782027953849;1021.1065317846884;1037.4968140451874;1042.4839704346246;1042.5725452564411;16092.758608621114;16496.34014639401;16831.72771675808;16871.91564042172;17158.142092895556;26023.73976260289;26992.73007269902;38001.42997854979;38666;39669.80165099156;50295.4793164475;51121.744391279295;53522;54207;58051.87273781758;5952.821415357546;7348.448866335153;8075.434719569574;8300.70947516834;8774.12258774143;10331.32846364984;11883.821742673694;12007.159498834997;12084.39578021113;12118.575849845212;10613.681589552325;10648.84026739584;10712.678619641423;10859.72850678728;11072.003519683267;10617.575296988034;10743.194260430342;10806.13550915909;11148.777024459627;11217.887821121685;11109.166812489257;11144.498497567467;11231.66305010851;11318.547258109584;11750.29498230109;8096.352291816523;8338.499690018618;8465.957670211856;8471.025832029396;8551.315894728283;9703.5148242589;10897.291676041032;11052.944735276273;11083.667489975314;11151 17:52:08 INFO - PROCESS | 13762 | |3;mootools.html;1305.1907817153367;1439.0933711761593;1448.9420423183071;1569.8822588305873;1763.391629887689;7262.927370726291;7832.882506762396;8069.193080691943;8084.2724154826055;8318.08501064884;8158.836823263531;8202.179782021794;8211.302039326649;8223.506589604627;8226.136255693156;2222.4999375140624;2241;2247.685324054634;2249.9887500562554;2252.0653928619604;2133.893305334735;2173.0330003148606;2219.9889000554977;2222.0778376973535;2226.955460890781;2188.5513469738744;2196.2422964077446;2206.79035491628;2211.1929145861804;2231.509068005036;2166.6425039868404;2176.1186719378597;2185.3990152707975;2186.3113119367426;2193.396815875639;2145.8819764912923;2151.688005239247;2151.9139234430604;2154.795294447025;2160.3842904772064;8129.918700813035;8186.467879587808;8213.712520061768;8346.081930987586;8481.533515656636;4963.354763880709;5143.228515722634;5150.227465880111;5152.871178220575;5154.38147422308;3220.388126256004;3376.4766461198556;3413.7951722896705;3422.9486557701653;3436.1237884339585;1073.125402796726;1150.8388825564427;1154.4458659843322;1169.3276366089447;1169.6374124021581;11643;11727.237729547553;11733.413329333585;11737.765244695143;11739.119566032496;4046.2312160689376;4270.743755374688;4302.82788688449;4433.800478978454;4519.344695019204;8891.91108088911;8895.777605559913;8900.599473023729;8901.955490222637;8904.73285801427;4859.07677541266;4866.124097662384;4867.70793752376;4869.902601947942;4873.878153046202;4099.713020088565;4235.597618226264;4487.730736155841;4580.198465268565;4581.839635612738;3720.813959302024;3861;3889.86385476507;3893.785841778673;4051.453053837753;1255.7614053329837;1287.3177216075494;1290.11627035481;1294.6180876641224;1300.7333496633357;848.8387206430758;850.8170743290223;866.4411454611866;869.1352104655781;870.1211776106052;4954.497978520824;5040.722760248148;5119.360079990001;5163.586913046947;5312.123499622597;453.4966187531837;458.3720303184658;467.03790192204167;470.2945581627559;478.818049141331;3452.896413107611;3486.633903440153;3522.295540891832;3524.54180956474;3550.9644903551152;10020.148287395654;10413.114885234689;10422.478876056166;10422.739431514121;10431.113355364727;10333.483325833678;10353.4305613192;10374.636887708893;10379;10384.896151038543;7719.845603087907;7754.3796496280165;7849.646765895548;7928.524288542706;7950.1254861965135;5091.0581542414775;5134;5156.948430515647;5225.686458812484;5268.868278293074;9216.631334746535;9318.254539636948;9497.952510237405;9533.046695330411;9776.364536305402;9427.3400861939;9782.119609235204;9845.360051596623;9867.802643946938;9913.504324783877;6556.311587283458;6839.213490448463;7466.813329666802;7534.434917381328;7538.736144234926;7792.571408572583;8009.719659811879;8022.91977080245;8100.797480063045;8104.230098140667;7087.149542054986;7113.217546070032;7154.463415243774;7199.028131202221;7534.698612055457;6777.695003724745;7071.186813516511;7107.324804143598;7171.318724721144;7190.316919892602;6373.203349581302;6406.87186256263;6426.871462570816;6440.323766004502;6511.055896894829;4428.734275943454;4447.3329000650165;4545.022820093695;4559.977200113978;4647.047355292089;4482.417285752831;4605.838795642137;4608.470025946925;4621.79201935907;4665.533446655443 17:52:08 INFO - PROCESS | 13762 | |4;prototype.html;323.41300539520773;327.95900512435946;331.1109670534614;339.1673441700625;342.3085367557534;5168;5206;5208.947910520894;5211.0458578033285;5263.0000299942985;5137.537621614054;5144.971005798837;5232.947670523294;5258.36899572051;5273.34083239595;3875.9922420170747;4001.5398229203724;4070.5929407059352;4081.9591804081874;4108.548059713429;4103.343465045593;4109;4123.340265557511;4131.521087347597;4134.917301653965;4074.470318858544;4085.22380747657;4085.46888904442;4091.2022155679656;4136.152088821799;3851.55426304296;3903.551091624443;3959;4071.1043570414463;4085.7130004048777;3625.111847597329;3628.1473853644375;3628.8548458061646;3632.219072899339;3638.072291565634;5042.596592272646;5044.924326135111;5045.5459008689395;5053.740337482303;5061.746912654389;4513.909721805579;4625.930611040837;4651.930221046653;4683.103343146031;4689.788959496831;5377.274068000809;5389.67661940281;5389.78729785799;5390.407055223922;5399.271098401744;3988.900277493086;3990.5235063026867;3991.6607088397523;3999.7600143991453;4002.3396139636925;5410.188471729232;5544.16837474378;5584.385717571024;5674.347450043257;5692.345380281279;4081.3469844824685;4092.4884389451317;4093.324601440729;4099.380744605924;4113.691473139466;4156.815307637369;4184.205001049791;4187.91624167515;4189.664826813848;4192.853250136231;4429.579189977011;4704.600108990774;4739.881502962385;4740.66815322931;4746.644001699887;5444.91832622511;5447.509724124848;5449.482299181572;5459.317585301837;5516.3380394352935;1376.8347798264272;1394.965125871841;1396.3576754692751;1403.4456389726206;1403.5578792680478;878.508035500122;921.9907800921904;924.9167574918155;935.5743136872707;944.8204841080172;5034.974825125851;5147.176451767774;5149.639525233272;5163.277141200235;5177.171652535576;5382.569394448435;5552;5554.638948468418;5570.498655120978;5659.858503537363;5175.731945673334;5208.479152084761;5239.869003274948;5242.397124330751;5322.414534401213;2925.9414811703646;2933.398653276073;2945.27840679035;2960.86676099576;2986.2982199183175;5602.85992850182;5644.814588936288;5661.2923384576925;5723.771049157987;5726.541876649858;5435.211894275308;5510.201020851954;5581.023320918823;5584.497395234448;5588.21764952907;5611.719414029282;5656.604037717402;5711.200431939449;5712.80005199816;5734.827955161435;5256.239159881483;5424.53891419218;5560.443955604407;5563.443655634566;5659.6887171204335;5424.891502170013;5436.864078398072;5465.508104270635;5473.72840271283;5477.260569823023;5631.802886899103;5647.943520564741;5658.519025882846;5667.4615911488345;5769.298057073257;3878.3794592865006;3982.2433737589763;3985.16311574561;4008.6191811777835;4020.457238272913;5492.5605951524585;5513.145462453326;5521.868017056413;5528.44715528444;5543.223948647112;5283.603729720363;5363.5440987516495;5388.838334849961;5467.425920278313;5481.588880833874;5191.312823332357;5415;5422.403535611001;5435.510804027656;5447.509724124848;5293.708846013352;5347.171188465794;5356.544693701079;5360.839174824761;5379.193121031876;5254.42201357858;5289.259503669567;5321.175217841086;5331.546818520469;5386.919196211981;4940.7035577865445;5188;5346.78612855497;5366.597505187048;5389.730513474389 17:52:08 INFO - PROCESS | 13762 | |5;yui.html;696.6377483708471;697.8555169521989;710.7157137145141;742.2836962331351;781.7654703588926;13804.378802953866;14458.421663133488;14466.710665786692;14510.854891451083;14624.707505849876;14719.264036798171;15761.921190394032;15958.122303273316;16017.83982160181;16040.83959160408;656.3370995294739;671.9395254427101;802.1617409806752;824.46821799939;827.8716798896181;789;818.467995802727;822.6750433578733;825.3438516379463;826.5990994367756;863.2360361080457;865.1737590600992;866.1122349591656;866.1901122450529;866.1944391715701;683.5864302097209;859.26532814444;860.6342304520585;860.9139086091403;861.1990848510883;507.4240736763763;601.6059481039925;614.216873486304;616.7779599344233;616.9629822210682;14589.854101458955;14759.631009224748;14797.556073317817;14808.3336249869;14814.925925370411;13855.376508057061;14110.435582576685;14574.344154513072;14646.780298295427;14953;13347.265900375573;13474.663133421645;13480.93259533696;13650.317484125753;13824.861751382457;4447.7776111194635;4486.125205584913;4493.786677597063;4558.202314594966;4726.243800991825;78882.21117788806;79031.60484197542;79501.60249198717;80169.59915200445;81760.59119704363;11006.174536909764;11033.448327583588;11282.887171128348;11332.830007549894;11340.376279304552;22425.439364015703;22478.887605561868;22568.435789105075;22587.548249034928;22626.773732262467;8406.831863362699;8456.365772566958;8479.660813567389;8514.659413623509;8614.18165274298;4666.0901124280435;4666.440027196758;4731.503192164842;4776.10753201306;4827.468978412372;3440.36353274645;3545.911352216215;3547.3614749345365;3549.538559987185;3550.0592343029116;588.6615196262167;594.8631814682648;595.2767387624058;595.4700316718124;596.9492593129546;536.9328833895763;539.3366159623685;616.9203893186923;646.660503235805;683.6171743823475;8670.739877803677;8973.192412682889;9073.954630226806;9383.202427793714;9410.506750342242;635.3424205946823;656.186328952096;668.9899651505232;669.668514085521;721.7618185998608;4606.193916064675;4616.561426664462;4667.113248482778;4674.789634466457;4676.825276246494;65850;66576;66833.66583167053;74712.62643686855;112803.43598281956;102009;103061.48469257756;104070.4796476028;105118;105668.47165764122;52305;57194.42805571974;68247.65876170587;71589.64205178941;82194.17805821986;8498.872516912128;8603.612837422206;8651.091635378194;8663.95668021656;8853.911460885567;48175;50932.23601646053;51819.96360072853;52562.474375255755;53143.73428132835;44507.332390014824;44704;58664.70667646635;73980.26019739734;74680.62659686667;12069.396530173632;12181.33002684861;12271.263724176579;12515.87484125147;13113.409896554487;13065.673358166121;13113.147645403018;13301.268430236043;13772;13864.86135138676;11327.15046371509;11582.94208528952;11743.47154378072;11784.76430471403;12162.513499459923;12144.635660930186;12182.39088045612;12256.571020014257;12390.194637348544;12425.44085516172;10961;11034.779304414027;11075.778484430428;11326.093912486816;11616.303021818718;9749.561269742737;9815.257940341588;10023.899761002296;10145.695629131138;10479.476026198507;9510.476923768982;9611.327207095435;9635.518224088908;9761.951190244003;9773.511324433892 17:52:08 INFO - PROCESS | 13762 | __end_tp_report 17:52:08 INFO - PROCESS | 13762 | __start_cc_report 17:52:08 INFO - PROCESS | 13762 | _x_x_mozilla_cycle_collect,1766 17:52:08 INFO - PROCESS | 13762 | __end_cc_report 17:52:08 INFO - PROCESS | 13762 | __startTimestamp1475542328336__endTimestamp 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | ------- Summary: start ------- 17:52:08 INFO - PROCESS | 13762 | Number of tests: 6 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#0] dojo.html Cycles:165 Average:5213.09 Median:5340.76 stddev:577.63 (10.8%) stddev-sans-first:553.31 17:52:08 INFO - PROCESS | 13762 | Values: 3024.9 3048.6 3056.1 3086.4 3104.1 5162.1 5267.1 5277.6 5315.1 5338.7 5199.1 5260.8 5296.2 5340.8 5391.4 4726.3 4752.9 4753.3 4759.0 4877.7 4877.4 4905.6 4912.3 4915.9 4947.2 4654.8 4693.9 4778.3 4857.3 4884.4 4804.2 4815.4 4873.5 4887.6 4889.7 4754.3 4774.0 4781.5 4794.7 4851.0 5113.4 5247.9 5253.4 5259.0 5314.7 5481.9 5572.7 5597.3 5598.4 5601.0 5642.9 5728.9 5731.8 5739.6 5746.2 5277.1 5281.9 5284.8 5285.7 5287.3 5719.6 5762.9 5791.2 5793.2 5860.3 5354.4 5390.2 5500.0 5503.5 5558.7 5563.3 5578.3 5581.8 5583.9 5642.3 5483.6 5547.4 5554.7 5555.9 5565.8 5403.1 5404.6 5464.3 5489.6 5641.2 4278.1 4283.7 4329.9 4331.2 4343.3 3817.9 3824.4 3824.8 3868.4 3875.7 5222.2 5225.4 5228.3 5288.1 5290.6 5603.6 5635.8 5641.3 5657.5 5722.1 5286.9 5289.9 5295.4 5303.4 5318.0 4761.4 4918.3 4928.9 4937.7 4975.5 5637.9 5747.6 5812.4 5828.2 5928.4 5638.7 5683.4 5692.3 5694.9 5698.4 5852.2 5876.9 5887.1 5890.1 5890.4 5388.3 5392.4 5416.8 5424.2 5434.6 5534.4 5534.7 5539.3 5561.8 5590.1 5386.4 5412.6 5424.2 5426.3 5489.3 5273.8 5311.5 5320.2 5326.9 5391.1 5319.3 5321.4 5322.4 5323.9 5326.0 5482.1 5533.9 5534.2 5536.0 5566.4 5433.5 5438.6 5446.7 5447.7 5451.1 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#1] ext.html Cycles:180 Average:60039.18 Median:42062.07 stddev:117449.24 (279.2%) stddev-sans-first:117693.87 17:52:08 INFO - PROCESS | 13762 | Values: 578.9 597.0 610.6 617.5 642.4 31981.0 42631.8 43413.8 43584.1 47285.3 46223.8 46406.0 46505.0 46566.5 46748.8 8906.6 9025.0 9032.6 9047.5 9064.0 8874.6 8962.6 8967.2 8969.9 8970.7 8943.3 8984.3 8987.8 8992.0 8995.3 8899.4 8937.3 8946.1 8947.8 8950.8 8877.3 8929.6 8945.6 8947.1 8949.9 42838.0 43094.0 43219.8 43229.8 43377.8 3265.1 3597.9 3829.9 4028.6 4130.1 32055.5 32499.2 32587.8 32726.3 32767.2 4265.6 4372.9 4478.4 4605.4 4611.9 358557.0 360371.0 361118.0 362063.0 362206.0 48928.8 50308.2 58228.0 58473.1 59643.0 58169.4 58424.1 65605.3 65988.7 66199.3 17336.8 17561.0 17577.6 17585.8 17587.6 11354.5 12406.4 12443.8 12471.4 12513.7 16485.5 19105.6 19369.7 20121.4 20271.7 7294.9 7315.5 7386.7 7463.7 7610.8 910.4 931.9 1045.4 1066.5 1152.4 30304.8 31762.0 31791.0 31864.7 32363.0 1072.9 1076.7 1115.4 1123.5 1142.3 15669.6 17016.7 17028.7 17031.5 17297.7 547607.0 550322.0 551540.0 552064.0 552225.0 59725.1 59981.0 60055.0 60070.4 60208.4 1219.1 1237.8 1241.9 1248.7 1305.3 30380.5 33560.3 34049.3 34175.8 34353.7 50508.7 51114.2 51155.2 51200.5 51287.0 392086.0 393925.0 395161.0 395476.0 396428.0 28341.7 29220.3 29241.3 29274.1 30508.8 47898.5 48112.5 48201.0 48472.0 49944.3 40563.0 41123.4 41423.4 41916.2 43339.6 41148.8 41286.6 41483.6 41992.1 42162.4 40920.0 41352.2 41406.8 41980.4 42132.0 34664.0 36316.8 37030.0 37286.6 37623.4 27535.0 27691.7 28012.0 28060.6 28133.7 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#2] jquery.html Cycles:180 Average:28611.04 Median:2350.98 stddev:81260.94 (3456.5%) stddev-sans-first:81461.23 17:52:08 INFO - PROCESS | 13762 | Values: 372.7 383.1 390.3 394.7 418.4 13644.9 14833.0 16726.2 19413.4 19509.6 18512.8 18647.9 18780.0 18991.5 19043.4 5602.9 5851.4 5867.9 5870.1 5874.6 4896.4 6474.0 6513.9 6581.7 6623.8 6263.0 6409.2 6584.3 6590.2 6592.5 6425.8 6449.8 6475.8 6486.3 6486.7 5560.9 5647.9 5784.2 5799.9 5802.1 22335.3 22581.9 22583.2 22786.2 22950.4 2321.0 2381.0 2397.4 2424.0 2450.0 14044.3 14178.7 14183.8 14439.2 14468.0 1883.4 1884.8 1925.7 1961.7 2012.9 81513.6 82750.0 83473.0 83875.0 84034.2 10512.5 10644.5 10877.5 11440.9 11747.6 15437.9 15439.6 15487.9 15499.5 15525.8 8257.3 8399.0 8421.5 8565.3 8615.4 7920.3 7933.3 8018.2 8277.5 8292.0 6485.4 6501.6 6579.2 6616.0 6660.7 1834.5 1936.1 1944.1 1951.2 1956.2 885.4 964.4 976.3 1011.7 1037.1 18000.6 18454.4 18923.1 18992.5 19777.4 1005.7 1054.9 1082.5 1107.1 1107.2 10281.6 10916.9 10942.7 10950.8 11027.2 469680.0 479766.0 501364.0 507377.0 510403.0 84506.0 84860.6 85028.0 85937.0 86551.0 990.8 1021.1 1037.5 1042.5 1042.6 16092.8 16496.3 16831.7 16871.9 17158.1 26023.7 26992.7 38001.4 38666.0 39669.8 50295.5 51121.7 53522.0 54207.0 58051.9 5952.8 7348.4 8075.4 8300.7 8774.1 10331.3 11883.8 12007.2 12084.4 12118.6 10613.7 10648.8 10712.7 10859.7 11072.0 10617.6 10743.2 10806.1 11148.8 11217.9 11109.2 11144.5 11231.7 11318.5 11750.3 8096.4 8338.5 8466.0 8471.0 8551.3 9703.5 10897.3 11052.9 11083.7 11151.0 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#3] mootools.html Cycles:180 Average:5383.51 Median:4656.29 stddev:3097.74 (66.5%) stddev-sans-first:3091.26 17:52:08 INFO - PROCESS | 13762 | Values: 1305.2 1439.1 1448.9 1569.9 1763.4 7262.9 7832.9 8069.2 8084.3 8318.1 8158.8 8202.2 8211.3 8223.5 8226.1 2222.5 2241.0 2247.7 2250.0 2252.1 2133.9 2173.0 2220.0 2222.1 2227.0 2188.6 2196.2 2206.8 2211.2 2231.5 2166.6 2176.1 2185.4 2186.3 2193.4 2145.9 2151.7 2151.9 2154.8 2160.4 8129.9 8186.5 8213.7 8346.1 8481.5 4963.4 5143.2 5150.2 5152.9 5154.4 3220.4 3376.5 3413.8 3422.9 3436.1 1073.1 1150.8 1154.4 1169.3 1169.6 11643.0 11727.2 11733.4 11737.8 11739.1 4046.2 4270.7 4302.8 4433.8 4519.3 8891.9 8895.8 8900.6 8902.0 8904.7 4859.1 4866.1 4867.7 4869.9 4873.9 4099.7 4235.6 4487.7 4580.2 4581.8 3720.8 3861.0 3889.9 3893.8 4051.5 1255.8 1287.3 1290.1 1294.6 1300.7 848.8 850.8 866.4 869.1 870.1 4954.5 5040.7 5119.4 5163.6 5312.1 453.5 458.4 467.0 470.3 478.8 3452.9 3486.6 3522.3 3524.5 3551.0 10020.1 10413.1 10422.5 10422.7 10431.1 10333.5 10353.4 10374.6 10379.0 10384.9 7719.8 7754.4 7849.6 7928.5 7950.1 5091.1 5134.0 5156.9 5225.7 5268.9 9216.6 9318.3 9498.0 9533.0 9776.4 9427.3 9782.1 9845.4 9867.8 9913.5 6556.3 6839.2 7466.8 7534.4 7538.7 7792.6 8009.7 8022.9 8100.8 8104.2 7087.1 7113.2 7154.5 7199.0 7534.7 6777.7 7071.2 7107.3 7171.3 7190.3 6373.2 6406.9 6426.9 6440.3 6511.1 4428.7 4447.3 4545.0 4560.0 4647.0 4482.4 4605.8 4608.5 4621.8 4665.5 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#4] prototype.html Cycles:180 Average:4570.85 Median:5222.00 stddev:1321.57 (25.3%) stddev-sans-first:1286.25 17:52:08 INFO - PROCESS | 13762 | Values: 323.4 328.0 331.1 339.2 342.3 5168.0 5206.0 5208.9 5211.0 5263.0 5137.5 5145.0 5232.9 5258.4 5273.3 3876.0 4001.5 4070.6 4082.0 4108.5 4103.3 4109.0 4123.3 4131.5 4134.9 4074.5 4085.2 4085.5 4091.2 4136.2 3851.6 3903.6 3959.0 4071.1 4085.7 3625.1 3628.1 3628.9 3632.2 3638.1 5042.6 5044.9 5045.5 5053.7 5061.7 4513.9 4625.9 4651.9 4683.1 4689.8 5377.3 5389.7 5389.8 5390.4 5399.3 3988.9 3990.5 3991.7 3999.8 4002.3 5410.2 5544.2 5584.4 5674.3 5692.3 4081.3 4092.5 4093.3 4099.4 4113.7 4156.8 4184.2 4187.9 4189.7 4192.9 4429.6 4704.6 4739.9 4740.7 4746.6 5444.9 5447.5 5449.5 5459.3 5516.3 1376.8 1395.0 1396.4 1403.4 1403.6 878.5 922.0 924.9 935.6 944.8 5035.0 5147.2 5149.6 5163.3 5177.2 5382.6 5552.0 5554.6 5570.5 5659.9 5175.7 5208.5 5239.9 5242.4 5322.4 2925.9 2933.4 2945.3 2960.9 2986.3 5602.9 5644.8 5661.3 5723.8 5726.5 5435.2 5510.2 5581.0 5584.5 5588.2 5611.7 5656.6 5711.2 5712.8 5734.8 5256.2 5424.5 5560.4 5563.4 5659.7 5424.9 5436.9 5465.5 5473.7 5477.3 5631.8 5647.9 5658.5 5667.5 5769.3 3878.4 3982.2 3985.2 4008.6 4020.5 5492.6 5513.1 5521.9 5528.4 5543.2 5283.6 5363.5 5388.8 5467.4 5481.6 5191.3 5415.0 5422.4 5435.5 5447.5 5293.7 5347.2 5356.5 5360.8 5379.2 5254.4 5289.3 5321.2 5331.5 5386.9 4940.7 5188.0 5346.8 5366.6 5389.7 17:52:08 INFO - PROCESS | 13762 | 17:52:08 INFO - PROCESS | 13762 | [#5] yui.html Cycles:180 Average:18766.85 Median:26501.23 stddev:26222.36 (98.9%) stddev-sans-first:26260.82 17:52:08 INFO - PROCESS | 13762 | Values: 696.6 697.9 710.7 742.3 781.8 13804.4 14458.4 14466.7 14510.9 14624.7 14719.3 15761.9 15958.1 16017.8 16040.8 656.3 671.9 802.2 824.5 827.9 789.0 818.5 822.7 825.3 826.6 863.2 865.2 866.1 866.2 866.2 683.6 859.3 860.6 860.9 861.2 507.4 601.6 614.2 616.8 617.0 14589.9 14759.6 14797.6 14808.3 14814.9 13855.4 14110.4 14574.3 14646.8 14953.0 13347.3 13474.7 13480.9 13650.3 13824.9 4447.8 4486.1 4493.8 4558.2 4726.2 78882.2 79031.6 79501.6 80169.6 81760.6 11006.2 11033.4 11282.9 11332.8 11340.4 22425.4 22478.9 22568.4 22587.5 22626.8 8406.8 8456.4 8479.7 8514.7 8614.2 4666.1 4666.4 4731.5 4776.1 4827.5 3440.4 3545.9 3547.4 3549.5 3550.1 588.7 594.9 595.3 595.5 596.9 536.9 539.3 616.9 646.7 683.6 8670.7 8973.2 9074.0 9383.2 9410.5 635.3 656.2 669.0 669.7 721.8 4606.2 4616.6 4667.1 4674.8 4676.8 65850.0 66576.0 66833.7 74712.6 112803.4 102009.0 103061.5 104070.5 105118.0 105668.5 52305.0 57194.4 68247.7 71589.6 82194.2 8498.9 8603.6 8651.1 8664.0 8853.9 48175.0 50932.2 51820.0 52562.5 53143.7 44507.3 44704.0 58664.7 73980.3 74680.6 12069.4 12181.3 12271.3 12515.9 13113.4 13065.7 13113.1 13301.3 13772.0 13864.9 11327.2 11582.9 11743.5 11784.8 12162.5 12144.6 12182.4 12256.6 12390.2 12425.4 10961.0 11034.8 11075.8 11326.1 11616.3 9749.6 9815.3 10023.9 10145.7 10479.5 9510.5 9611.3 9635.5 9762.0 9773.5 17:52:08 INFO - PROCESS | 13762 | -------- Summary: end -------- 17:52:08 INFO - PROCESS | 13762 | 17:52:09 INFO - TEST-INFO | 13762: exit 0 17:52:09 INFO - TEST-OK | dromaeo_css | took 1117348ms 17:52:09 INFO - TEST-START | kraken 17:52:09 INFO - operating with platform_type : linux_ 17:52:09 INFO - Initialising browser for kraken test... 17:52:09 INFO - TEST-INFO | started process 14066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_u0Br/profile http://localhost:34059/getInfo.html) 17:52:13 INFO - PROCESS | 14066 | __metrics Screen width/height:1600/1200 17:52:13 INFO - PROCESS | 14066 | colorDepth:24 17:52:13 INFO - PROCESS | 14066 | Browser inner width/height: 1024/697 17:52:13 INFO - PROCESS | 14066 | __metrics 17:52:13 INFO - PROCESS | 14066 | 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" 17:52:13 INFO - PROCESS | 14066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:52:14 INFO - PROCESS | 14066 | console.error: PushService: 17:52:14 INFO - PROCESS | 14066 | stateChangeProcessEnqueue: Error transitioning state 17:52:14 INFO - PROCESS | 14066 | UnknownError 17:52:14 INFO - TEST-INFO | 14066: exit 0 17:52:14 INFO - Browser initialized. 17:52:14 INFO - Running cycle 1/1 for kraken test... 17:52:14 INFO - TEST-INFO | started process 14147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_u0Br/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:27 INFO - PROCESS | 14147 | RSS: Main: 176037888 17:52:27 INFO - PROCESS | 14147 | 17:52:29 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-beat-detection) 17:52:30 INFO - PROCESS | 14147 | RSS: Main: 232759296 17:52:30 INFO - PROCESS | 14147 | 17:52:33 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-dft) 17:52:33 INFO - PROCESS | 14147 | RSS: Main: 217661440 17:52:33 INFO - PROCESS | 14147 | 17:52:36 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-fft) 17:52:37 INFO - PROCESS | 14147 | RSS: Main: 299061248 17:52:37 INFO - PROCESS | 14147 | 17:52:39 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-oscillator) 17:52:40 INFO - PROCESS | 14147 | RSS: Main: 208736256 17:52:40 INFO - PROCESS | 14147 | 17:52:42 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:42 INFO - PROCESS | 14147 | RSS: Main: 213094400 17:52:42 INFO - PROCESS | 14147 | 17:52:45 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:46 INFO - PROCESS | 14147 | RSS: Main: 249245696 17:52:46 INFO - PROCESS | 14147 | 17:52:49 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:50 INFO - PROCESS | 14147 | RSS: Main: 248582144 17:52:50 INFO - PROCESS | 14147 | 17:52:53 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34059/tests/kraken/driver.html?testName=json-parse-financial) 17:52:53 INFO - PROCESS | 14147 | RSS: Main: 248905728 17:52:53 INFO - PROCESS | 14147 | 17:52:55 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:55 INFO - PROCESS | 14147 | RSS: Main: 210763776 17:52:55 INFO - PROCESS | 14147 | 17:52:57 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:58 INFO - PROCESS | 14147 | RSS: Main: 217841664 17:52:58 INFO - PROCESS | 14147 | 17:53:00 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:53:01 INFO - PROCESS | 14147 | RSS: Main: 222781440 17:53:01 INFO - PROCESS | 14147 | 17:53:03 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:53:04 INFO - PROCESS | 14147 | RSS: Main: 224362496 17:53:04 INFO - PROCESS | 14147 | 17:53:07 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:53:07 INFO - PROCESS | 14147 | RSS: Main: 222687232 17:53:07 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34059/tests/kraken/driver.html?testName=ai-astar) 17:53:09 INFO - PROCESS | 14147 | RSS: Main: 273551360 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | __start_tp_report 17:53:09 INFO - PROCESS | 14147 | _x_x_mozilla_page_load 17:53:09 INFO - PROCESS | 14147 | _x_x_mozilla_page_load_details 17:53:09 INFO - PROCESS | 14147 | |i|pagename|runs| 17:53:09 INFO - PROCESS | 14147 | |0;ai-astar;109;113;112;112;112;112;112;112;112;114 17:53:09 INFO - PROCESS | 14147 | |1;audio-beat-detection;151;120;125;170;127;128;120;126;156;122 17:53:09 INFO - PROCESS | 14147 | |2;audio-dft;161;160;162;161;163;161;163;162;161;160 17:53:09 INFO - PROCESS | 14147 | |3;audio-fft;73;76;75;107;76;75;78;74;102;75 17:53:09 INFO - PROCESS | 14147 | |4;audio-oscillator;83;83;114;83;83;82;102;82;82;116 17:53:09 INFO - PROCESS | 14147 | |5;imaging-gaussian-blur;117;116;116;116;116;116;116;117;117;117 17:53:09 INFO - PROCESS | 14147 | |6;imaging-darkroom;145;146;146;145;145;146;146;146;146;145 17:53:09 INFO - PROCESS | 14147 | |7;imaging-desaturate;95;96;96;95;96;95;96;95;96;95 17:53:09 INFO - PROCESS | 14147 | |8;json-parse-financial;55;51;51;52;54;52;53;53;53;52 17:53:09 INFO - PROCESS | 14147 | |9;json-stringify-tinderbox;59;60;60;61;60;61;61;61;61;61 17:53:09 INFO - PROCESS | 14147 | |10;stanford-crypto-aes;79;80;84;80;80;79;79;85;81;79 17:53:09 INFO - PROCESS | 14147 | |11;stanford-crypto-ccm;143;136;145;129;129;128;128;132;167;139 17:53:09 INFO - PROCESS | 14147 | |12;stanford-crypto-pbkdf2;165;171;165;164;165;171;167;166;166;165 17:53:09 INFO - PROCESS | 14147 | |13;stanford-crypto-sha256-iterative;67;66;65;65;66;66;64;66;65;65 17:53:09 INFO - PROCESS | 14147 | __end_tp_report 17:53:09 INFO - PROCESS | 14147 | __start_cc_report 17:53:09 INFO - PROCESS | 14147 | _x_x_mozilla_cycle_collect,1662 17:53:09 INFO - PROCESS | 14147 | __end_cc_report 17:53:09 INFO - PROCESS | 14147 | __startTimestamp1475542389589__endTimestamp 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | ------- Summary: start ------- 17:53:09 INFO - PROCESS | 14147 | Number of tests: 14 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 17:53:09 INFO - PROCESS | 14147 | Values: 109.0 113.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 114.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:127.50 stddev:17.74 (13.9%) stddev-sans-first:17.78 17:53:09 INFO - PROCESS | 14147 | Values: 151.0 120.0 125.0 170.0 127.0 128.0 120.0 126.0 156.0 122.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 17:53:09 INFO - PROCESS | 14147 | Values: 161.0 160.0 162.0 161.0 163.0 161.0 163.0 162.0 161.0 160.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.46 (16.6%) stddev-sans-first:12.86 17:53:09 INFO - PROCESS | 14147 | Values: 73.0 76.0 75.0 107.0 76.0 75.0 78.0 74.0 102.0 75.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.50 stddev:14.04 (17.0%) stddev-sans-first:14.59 17:53:09 INFO - PROCESS | 14147 | Values: 83.0 83.0 114.0 83.0 83.0 82.0 102.0 82.0 82.0 116.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:53:09 INFO - PROCESS | 14147 | Values: 117.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:53:09 INFO - PROCESS | 14147 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:53:09 INFO - PROCESS | 14147 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.00 17:53:09 INFO - PROCESS | 14147 | Values: 55.0 51.0 51.0 52.0 54.0 52.0 53.0 53.0 53.0 52.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.71 (1.2%) stddev-sans-first:0.50 17:53:09 INFO - PROCESS | 14147 | Values: 59.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.17 (2.7%) stddev-sans-first:2.22 17:53:09 INFO - PROCESS | 14147 | Values: 79.0 80.0 84.0 80.0 80.0 79.0 79.0 85.0 81.0 79.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:137.50 stddev:12.09 (8.8%) stddev-sans-first:12.67 17:53:09 INFO - PROCESS | 14147 | Values: 143.0 136.0 145.0 129.0 129.0 128.0 128.0 132.0 167.0 139.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.00 stddev:2.51 (1.5%) stddev-sans-first:2.60 17:53:09 INFO - PROCESS | 14147 | Values: 165.0 171.0 165.0 164.0 165.0 171.0 167.0 166.0 166.0 165.0 17:53:09 INFO - PROCESS | 14147 | 17:53:09 INFO - PROCESS | 14147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 17:53:09 INFO - PROCESS | 14147 | Values: 67.0 66.0 65.0 65.0 66.0 66.0 64.0 66.0 65.0 65.0 17:53:09 INFO - PROCESS | 14147 | -------- Summary: end -------- 17:53:09 INFO - PROCESS | 14147 | 17:53:10 INFO - TEST-INFO | 14147: exit 0 17:53:10 INFO - TEST-OK | kraken | took 61449ms 17:53:10 INFO - SUITE-END | took 1178s 17:53:11 INFO - Completed test suite (00:19:39) 17:53:11 INFO - javascript benchmark 17:53:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.939501209976, 3048.588440560525, 3056.0678992907156, 3086.4290106330345, 3104.0998110547944, 5162.070827251093, 5267.051930652481, 5277.604179686519, 5315.123004704224, 5338.652987555811, 5199.14214154664, 5260.842614624777, 5296.232046353276, 5340.759665815038, 5391.406945236031, 4726.291056341542, 4752.881177970544, 4753.33453316536, 4758.952410475903, 4877.6829506081995, 4877.414710234777, 4905.632077594177, 4912.270219672974, 4915.901681966358, 4947.1589829728855, 4654.790534425959, 4693.859184224479, 4778.307145463923, 4857.319975203474, 4884.389451318603, 4804.231322988305, 4815.446223684286, 4873.537013983666, 4887.584555312803, 4889.682170658932, 4754.310624959361, 4774.045190961821, 4781.545753153445, 4794.712317260975, 4850.975745121287, 5113.386393632751, 5247.86880327991, 5253.3958594761325, 5259.0, 5314.654547454442, 5481.945180548183, 5572.721363931787, 5597.3003374578175, 5598.412166722476, 5600.991821472134, 5642.858928526779, 5728.942710572883, 5731.799387021434, 5739.598228124033, 5746.224259724925, 5277.076511610491, 5281.9471805281455, 5284.841454756363, 5285.656432331924, 5287.339082614673, 5719.554451764473, 5762.88474230513, 5791.160281759121, 5793.217915581343, 5860.267466566679, 5354.41101478837, 5390.19147127934, 5499.972500137474, 5503.477169668875, 5558.666480011131, 5563.332400112013, 5578.330600327987, 5581.804636837691, 5583.944160558423, 5642.322921249476, 5483.643563168382, 5547.417521160301, 5554.72226388679, 5555.916661250085, 5565.833025009256, 5403.135498320328, 5404.567634589223, 5464.3442786865835, 5489.64317319373, 5641.210230567724, 4278.101598664253, 4283.7429754214845, 4329.891752706145, 4331.155424692218, 4343.3484977253665, 3817.9427308590393, 3824.3689791184697, 3824.7513911595656, 3868.4390763339156, 3875.748076375027, 5222.242774797709, 5225.425203227642, 5228.346456692913, 5288.074586947346, 5290.603204759658, 5603.607747457639, 5635.830925072254, 5641.323041235078, 5657.51911087554, 5722.084466485426, 5286.867828304323, 5289.920651190235, 5295.443978382292, 5303.416624171338, 5318.042752304622, 4761.40482439695, 4918.262260660929, 4928.8767780805765, 4937.679050861682, 4975.527324904128, 5637.943620563824, 5747.597668163188, 5812.389699081536, 5828.242328497268, 5928.3775203603, 5638.693100933976, 5683.3748287687495, 5692.31692196939, 5694.914576281442, 5698.373178950229, 5852.18069470266, 5876.882462350643, 5887.0580707086665, 5890.116482527484, 5890.381509941394, 5388.299521062237, 5392.379876314118, 5416.808302173516, 5424.2406063151975, 5434.64674796137, 5534.39121696605, 5534.723263836872, 5539.279893613804, 5561.805336813192, 5590.105583106846, 5386.380566234933, 5412.621116521806, 5424.186372044225, 5426.294581704353, 5489.258950041693, 5273.762680679302, 5311.468853114658, 5320.175372817064, 5326.9200961984825, 5391.110466773095, 5319.335083114611, 5321.36143662763, 5322.38792538863, 5323.893522129613, 5326.0, 5482.122860342485, 5533.889322213614, 5534.169874518854, 5536.031194540858, 5566.415526369673, 5433.4566543345345, 5438.6192966493545, 5446.673199608036, 5447.727613619382, 5451.127819548853], "value": 5175.024400359684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.878435528539, 596.9791057312995, 610.6488768957851, 617.4720613875133, 642.4410762636506, 31981.0, 42631.78684106579, 43413.78293108538, 43584.12831743367, 47285.29072063922, 46223.76888115563, 46406.0, 46505.0, 46566.534334656644, 46748.766256168754, 8906.554672266393, 9025.0, 9032.638694452215, 9047.457152570867, 9064.048274931103, 8874.600642971049, 8962.641494340218, 8967.192952634261, 8969.865452018224, 8970.730878073635, 8943.32925030622, 8984.326175536828, 8987.820243595124, 8991.95504022479, 8995.28037756978, 8899.37704360695, 8937.329700272441, 8946.105389461067, 8947.821043579157, 8950.820983580357, 8877.334199934967, 8929.553522323922, 8945.597448114786, 8947.105289471066, 8949.865752013726, 42838.0, 43094.0, 43219.78390108029, 43229.78385108086, 43377.783111084245, 3265.1020969233414, 3597.928041439183, 3829.9234015319817, 4028.5568587455355, 4130.0500884796365, 32055.51916721251, 32499.18752031218, 32587.837060814545, 32726.345473090405, 32767.18082047968, 4265.552117027699, 4372.934405983913, 4478.395416618748, 4605.355250264965, 4611.861644150681, 358556.9999999974, 360370.9999999974, 361118.0, 362063.0, 362206.0, 48928.75535622299, 50308.245376319384, 58228.0, 58473.12290315649, 59643.0, 58169.41830581725, 58424.12363814546, 65605.34394656088, 65988.67005665037, 66199.33800662028, 17336.826631733773, 17561.0, 17577.560560986076, 17585.824141758676, 17587.648247034987, 11354.48904799286, 12406.379681015913, 12443.813342799865, 12471.376431178405, 12513.74972500545, 16485.505434836974, 19105.61788764217, 19369.698886889782, 20121.39635810928, 20271.695924561143, 7294.854102917912, 7315.536892621497, 7386.704531818667, 7463.738769143054, 7610.847783044308, 910.3581974707815, 931.9487428191379, 1045.3727763342085, 1066.5307264803462, 1152.4468255237532, 30304.84847575748, 31762.0, 31791.0, 31864.68135318617, 32363.0, 1072.9248952573246, 1076.6554702495127, 1115.4088333183427, 1123.5000424811044, 1142.2803633710876, 15669.60825979337, 17016.659666806594, 17028.744568831476, 17031.48905532836, 17297.65404691899, 547607.0, 550322.0, 551540.0, 552064.0, 552225.0, 59725.104123438185, 59981.0, 60055.0, 60070.39929600735, 60208.39791602115, 1219.1100496637505, 1237.7586370657634, 1241.8944389726973, 1248.7003119251497, 1305.288617703373, 30380.5442918352, 33560.328793423505, 34049.31901362009, 34175.829120854236, 34353.65646343504, 50508.747456263955, 51114.233286501476, 51155.232671510705, 51200.48799511957, 51287.0, 392086.0, 393925.0, 395161.0, 395476.0, 396428.0, 28341.71658283391, 29220.26949326199, 29241.26896827511, 29274.12177634589, 30508.847455762578, 47898.5210147894, 48112.518874810805, 48201.0, 48472.0, 49944.250836238214, 40563.0, 41123.38314925339, 41423.37864931968, 41916.16167676568, 43339.56660433482, 41148.79425602853, 41286.58713412828, 41483.58516414918, 41992.144883265064, 42162.36756448717, 40920.0, 41352.172956541304, 41406.79296603498, 41980.37029444622, 42132.0, 34664.0, 36316.81841590775, 37030.0, 37286.6271337294, 37623.43564846475, 27535.0, 27691.723082768913, 28012.0, 28060.579091314055, 28133.71866281311], "value": 20249.23904171229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.6683251905803, 383.1035377217311, 390.32278995942033, 394.73552719677815, 418.4497385937492, 13644.931775341121, 14833.035852669569, 16726.16369181542, 19413.417597472064, 19509.609807803834, 18512.81487185128, 18647.906760466212, 18780.0, 18991.525211869677, 19043.428697139072, 5602.887942241153, 5851.385604511529, 5867.8533036674, 5870.148828419877, 5874.647521148745, 4896.436909755388, 6474.028895665664, 6513.902291465632, 6581.670916454182, 6623.801285961405, 6263.0, 6409.198850143732, 6584.275729669733, 6590.2206404271055, 6592.538522303416, 6425.8393540161405, 6449.806505804833, 6475.773347932847, 6486.318936511669, 6486.675666216717, 5560.888782224373, 5647.943520564783, 5784.1902133701315, 5799.942000579982, 5802.100674395433, 22335.329940101823, 22581.887090564443, 22583.209587664518, 22786.202482913017, 22950.426239343982, 2320.953580928389, 2381.0, 2397.412633904687, 2423.9636405453934, 2449.9632505512254, 14044.297785110704, 14178.716425671531, 14183.78724319136, 14439.205843678594, 14468.0, 1883.3973128598855, 1884.8209420105204, 1925.7207704882853, 1961.6562654581514, 2012.87922724637, 81513.59243203746, 82750.0, 83473.0, 83875.0, 84034.15965840324, 10512.474376281309, 10644.520996555173, 10877.510512026978, 11440.885591144148, 11747.647570572897, 15437.922810385877, 15439.614009649624, 15487.922560387125, 15499.5350139496, 15525.84474155244, 8257.339412846957, 8398.958005209935, 8421.536815475085, 8565.271951884035, 8615.39692221551, 7920.287174154354, 7933.325667318227, 8018.158093400226, 8277.461964972257, 8292.04641466227, 6485.416312531895, 6501.609903405811, 6579.17760279965, 6615.966920165369, 6660.733570657217, 1834.4680042787443, 1936.1384184037968, 1944.134859987292, 1951.1610007696827, 1956.178405069874, 885.4377470306273, 964.3731574476506, 976.2629214942815, 1011.6610935336597, 1037.0873631204493, 18000.639987200182, 18454.446366608754, 18923.148458319407, 18992.52518687044, 19777.40667779969, 1005.6832097889142, 1054.8681414823147, 1082.4533610526792, 1107.1309022417363, 1107.2083460325905, 10281.635223898546, 10916.945415272872, 10942.671719848417, 10950.780984380268, 11027.22809403334, 469680.0, 479766.0, 501364.0, 507377.0, 510403.0, 84506.0, 84860.57569712236, 85028.0, 85937.0, 86551.0, 990.782027953849, 1021.1065317846884, 1037.4968140451874, 1042.4839704346246, 1042.5725452564411, 16092.758608621114, 16496.34014639401, 16831.72771675808, 16871.91564042172, 17158.142092895556, 26023.73976260289, 26992.73007269902, 38001.42997854979, 38666.0, 39669.80165099156, 50295.4793164475, 51121.744391279295, 53522.0, 54207.0, 58051.87273781758, 5952.821415357546, 7348.448866335153, 8075.434719569574, 8300.70947516834, 8774.12258774143, 10331.32846364984, 11883.821742673694, 12007.159498834997, 12084.39578021113, 12118.575849845212, 10613.681589552325, 10648.84026739584, 10712.678619641423, 10859.72850678728, 11072.003519683267, 10617.575296988034, 10743.194260430342, 10806.13550915909, 11148.777024459627, 11217.887821121685, 11109.166812489257, 11144.498497567467, 11231.66305010851, 11318.547258109584, 11750.29498230109, 8096.352291816523, 8338.499690018618, 8465.957670211856, 8471.025832029396, 8551.315894728283, 9703.5148242589, 10897.291676041032, 11052.944735276273, 11083.667489975314, 11151.0], "value": 9246.870750741786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.1907817153367, 1439.0933711761593, 1448.9420423183071, 1569.8822588305873, 1763.391629887689, 7262.927370726291, 7832.882506762396, 8069.193080691943, 8084.2724154826055, 8318.08501064884, 8158.836823263531, 8202.179782021794, 8211.302039326649, 8223.506589604627, 8226.136255693156, 2222.4999375140624, 2241.0, 2247.685324054634, 2249.9887500562554, 2252.0653928619604, 2133.893305334735, 2173.0330003148606, 2219.9889000554977, 2222.0778376973535, 2226.955460890781, 2188.5513469738744, 2196.2422964077446, 2206.79035491628, 2211.1929145861804, 2231.509068005036, 2166.6425039868404, 2176.1186719378597, 2185.3990152707975, 2186.3113119367426, 2193.396815875639, 2145.8819764912923, 2151.688005239247, 2151.9139234430604, 2154.795294447025, 2160.3842904772064, 8129.918700813035, 8186.467879587808, 8213.712520061768, 8346.081930987586, 8481.533515656636, 4963.354763880709, 5143.228515722634, 5150.227465880111, 5152.871178220575, 5154.38147422308, 3220.388126256004, 3376.4766461198556, 3413.7951722896705, 3422.9486557701653, 3436.1237884339585, 1073.125402796726, 1150.8388825564427, 1154.4458659843322, 1169.3276366089447, 1169.6374124021581, 11643.0, 11727.237729547553, 11733.413329333585, 11737.765244695143, 11739.119566032496, 4046.2312160689376, 4270.743755374688, 4302.82788688449, 4433.800478978454, 4519.344695019204, 8891.91108088911, 8895.777605559913, 8900.599473023729, 8901.955490222637, 8904.73285801427, 4859.07677541266, 4866.124097662384, 4867.70793752376, 4869.902601947942, 4873.878153046202, 4099.713020088565, 4235.597618226264, 4487.730736155841, 4580.198465268565, 4581.839635612738, 3720.813959302024, 3861.0, 3889.86385476507, 3893.785841778673, 4051.453053837753, 1255.7614053329837, 1287.3177216075494, 1290.11627035481, 1294.6180876641224, 1300.7333496633357, 848.8387206430758, 850.8170743290223, 866.4411454611866, 869.1352104655781, 870.1211776106052, 4954.497978520824, 5040.722760248148, 5119.360079990001, 5163.586913046947, 5312.123499622597, 453.4966187531837, 458.3720303184658, 467.03790192204167, 470.2945581627559, 478.818049141331, 3452.896413107611, 3486.633903440153, 3522.295540891832, 3524.54180956474, 3550.9644903551152, 10020.148287395654, 10413.114885234689, 10422.478876056166, 10422.739431514121, 10431.113355364727, 10333.483325833678, 10353.4305613192, 10374.636887708893, 10379.0, 10384.896151038543, 7719.845603087907, 7754.3796496280165, 7849.646765895548, 7928.524288542706, 7950.1254861965135, 5091.0581542414775, 5134.0, 5156.948430515647, 5225.686458812484, 5268.868278293074, 9216.631334746535, 9318.254539636948, 9497.952510237405, 9533.046695330411, 9776.364536305402, 9427.3400861939, 9782.119609235204, 9845.360051596623, 9867.802643946938, 9913.504324783877, 6556.311587283458, 6839.213490448463, 7466.813329666802, 7534.434917381328, 7538.736144234926, 7792.571408572583, 8009.719659811879, 8022.91977080245, 8100.797480063045, 8104.230098140667, 7087.149542054986, 7113.217546070032, 7154.463415243774, 7199.028131202221, 7534.698612055457, 6777.695003724745, 7071.186813516511, 7107.324804143598, 7171.318724721144, 7190.316919892602, 6373.203349581302, 6406.87186256263, 6426.871462570816, 6440.323766004502, 6511.055896894829, 4428.734275943454, 4447.3329000650165, 4545.022820093695, 4559.977200113978, 4647.047355292089, 4482.417285752831, 4605.838795642137, 4608.470025946925, 4621.79201935907, 4665.533446655443], "value": 4257.473449009758, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.41300539520773, 327.95900512435946, 331.1109670534614, 339.1673441700625, 342.3085367557534, 5168.0, 5206.0, 5208.947910520894, 5211.0458578033285, 5263.0000299942985, 5137.537621614054, 5144.971005798837, 5232.947670523294, 5258.36899572051, 5273.34083239595, 3875.9922420170747, 4001.5398229203724, 4070.5929407059352, 4081.9591804081874, 4108.548059713429, 4103.343465045593, 4109.0, 4123.340265557511, 4131.521087347597, 4134.917301653965, 4074.470318858544, 4085.22380747657, 4085.46888904442, 4091.2022155679656, 4136.152088821799, 3851.55426304296, 3903.551091624443, 3959.0, 4071.1043570414463, 4085.7130004048777, 3625.111847597329, 3628.1473853644375, 3628.8548458061646, 3632.219072899339, 3638.072291565634, 5042.596592272646, 5044.924326135111, 5045.5459008689395, 5053.740337482303, 5061.746912654389, 4513.909721805579, 4625.930611040837, 4651.930221046653, 4683.103343146031, 4689.788959496831, 5377.274068000809, 5389.67661940281, 5389.78729785799, 5390.407055223922, 5399.271098401744, 3988.900277493086, 3990.5235063026867, 3991.6607088397523, 3999.7600143991453, 4002.3396139636925, 5410.188471729232, 5544.16837474378, 5584.385717571024, 5674.347450043257, 5692.345380281279, 4081.3469844824685, 4092.4884389451317, 4093.324601440729, 4099.380744605924, 4113.691473139466, 4156.815307637369, 4184.205001049791, 4187.91624167515, 4189.664826813848, 4192.853250136231, 4429.579189977011, 4704.600108990774, 4739.881502962385, 4740.66815322931, 4746.644001699887, 5444.91832622511, 5447.509724124848, 5449.482299181572, 5459.317585301837, 5516.3380394352935, 1376.8347798264272, 1394.965125871841, 1396.3576754692751, 1403.4456389726206, 1403.5578792680478, 878.508035500122, 921.9907800921904, 924.9167574918155, 935.5743136872707, 944.8204841080172, 5034.974825125851, 5147.176451767774, 5149.639525233272, 5163.277141200235, 5177.171652535576, 5382.569394448435, 5552.0, 5554.638948468418, 5570.498655120978, 5659.858503537363, 5175.731945673334, 5208.479152084761, 5239.869003274948, 5242.397124330751, 5322.414534401213, 2925.9414811703646, 2933.398653276073, 2945.27840679035, 2960.86676099576, 2986.2982199183175, 5602.85992850182, 5644.814588936288, 5661.2923384576925, 5723.771049157987, 5726.541876649858, 5435.211894275308, 5510.201020851954, 5581.023320918823, 5584.497395234448, 5588.21764952907, 5611.719414029282, 5656.604037717402, 5711.200431939449, 5712.80005199816, 5734.827955161435, 5256.239159881483, 5424.53891419218, 5560.443955604407, 5563.443655634566, 5659.6887171204335, 5424.891502170013, 5436.864078398072, 5465.508104270635, 5473.72840271283, 5477.260569823023, 5631.802886899103, 5647.943520564741, 5658.519025882846, 5667.4615911488345, 5769.298057073257, 3878.3794592865006, 3982.2433737589763, 3985.16311574561, 4008.6191811777835, 4020.457238272913, 5492.5605951524585, 5513.145462453326, 5521.868017056413, 5528.44715528444, 5543.223948647112, 5283.603729720363, 5363.5440987516495, 5388.838334849961, 5467.425920278313, 5481.588880833874, 5191.312823332357, 5415.0, 5422.403535611001, 5435.510804027656, 5447.509724124848, 5293.708846013352, 5347.171188465794, 5356.544693701079, 5360.839174824761, 5379.193121031876, 5254.42201357858, 5289.259503669567, 5321.175217841086, 5331.546818520469, 5386.919196211981, 4940.7035577865445, 5188.0, 5346.78612855497, 5366.597505187048, 5389.730513474389], "value": 4150.379540274307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6377483708471, 697.8555169521989, 710.7157137145141, 742.2836962331351, 781.7654703588926, 13804.378802953866, 14458.421663133488, 14466.710665786692, 14510.854891451083, 14624.707505849876, 14719.264036798171, 15761.921190394032, 15958.122303273316, 16017.83982160181, 16040.83959160408, 656.3370995294739, 671.9395254427101, 802.1617409806752, 824.46821799939, 827.8716798896181, 789.0, 818.467995802727, 822.6750433578733, 825.3438516379463, 826.5990994367756, 863.2360361080457, 865.1737590600992, 866.1122349591656, 866.1901122450529, 866.1944391715701, 683.5864302097209, 859.26532814444, 860.6342304520585, 860.9139086091403, 861.1990848510883, 507.4240736763763, 601.6059481039925, 614.216873486304, 616.7779599344233, 616.9629822210682, 14589.854101458955, 14759.631009224748, 14797.556073317817, 14808.3336249869, 14814.925925370411, 13855.376508057061, 14110.435582576685, 14574.344154513072, 14646.780298295427, 14953.0, 13347.265900375573, 13474.663133421645, 13480.93259533696, 13650.317484125753, 13824.861751382457, 4447.7776111194635, 4486.125205584913, 4493.786677597063, 4558.202314594966, 4726.243800991825, 78882.21117788806, 79031.60484197542, 79501.60249198717, 80169.59915200445, 81760.59119704363, 11006.174536909764, 11033.448327583588, 11282.887171128348, 11332.830007549894, 11340.376279304552, 22425.439364015703, 22478.887605561868, 22568.435789105075, 22587.548249034928, 22626.773732262467, 8406.831863362699, 8456.365772566958, 8479.660813567389, 8514.659413623509, 8614.18165274298, 4666.0901124280435, 4666.440027196758, 4731.503192164842, 4776.10753201306, 4827.468978412372, 3440.36353274645, 3545.911352216215, 3547.3614749345365, 3549.538559987185, 3550.0592343029116, 588.6615196262167, 594.8631814682648, 595.2767387624058, 595.4700316718124, 596.9492593129546, 536.9328833895763, 539.3366159623685, 616.9203893186923, 646.660503235805, 683.6171743823475, 8670.739877803677, 8973.192412682889, 9073.954630226806, 9383.202427793714, 9410.506750342242, 635.3424205946823, 656.186328952096, 668.9899651505232, 669.668514085521, 721.7618185998608, 4606.193916064675, 4616.561426664462, 4667.113248482778, 4674.789634466457, 4676.825276246494, 65850.0, 66576.0, 66833.66583167053, 74712.62643686855, 112803.43598281956, 102009.0, 103061.48469257756, 104070.4796476028, 105118.0, 105668.47165764122, 52305.0, 57194.42805571974, 68247.65876170587, 71589.64205178941, 82194.17805821986, 8498.872516912128, 8603.612837422206, 8651.091635378194, 8663.95668021656, 8853.911460885567, 48175.0, 50932.23601646053, 51819.96360072853, 52562.474375255755, 53143.73428132835, 44507.332390014824, 44704.0, 58664.70667646635, 73980.26019739734, 74680.62659686667, 12069.396530173632, 12181.33002684861, 12271.263724176579, 12515.87484125147, 13113.409896554487, 13065.673358166121, 13113.147645403018, 13301.268430236043, 13772.0, 13864.86135138676, 11327.15046371509, 11582.94208528952, 11743.47154378072, 11784.76430471403, 12162.513499459923, 12144.635660930186, 12182.39088045612, 12256.571020014257, 12390.194637348544, 12425.44085516172, 10961.0, 11034.779304414027, 11075.778484430428, 11326.093912486816, 11616.303021818718, 9749.561269742737, 9815.257940341588, 10023.899761002296, 10145.695629131138, 10479.476026198507, 9510.476923768982, 9611.327207095435, 9635.518224088908, 9761.951190244003, 9773.511324433892], "value": 7162.0228038095765, "unit": "score"}], "name": "dromaeo_css", "value": 7048.665161849206, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 125.0, 170.0, 127.0, 128.0, 120.0, 126.0, 156.0, 122.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 163.0, 161.0, 163.0, 162.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 107.0, 76.0, 75.0, 78.0, 74.0, 102.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 83.0, 83.0, 82.0, 102.0, 82.0, 82.0, 116.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 52.0, 54.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 84.0, 80.0, 80.0, 79.0, 79.0, 85.0, 81.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 145.0, 129.0, 129.0, 128.0, 128.0, 132.0, 167.0, 139.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 165.0, 164.0, 165.0, 171.0, 167.0, 166.0, 166.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1500.7999999999997, "alertThreshold": 2.0}]} 17:53:11 INFO - Return code: 0 17:53:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:53:11 INFO - # TBPL SUCCESS # 17:53:11 INFO - Running post-action listener: _resource_record_post_action 17:53:11 INFO - [mozharness: 2016-10-04 00:53:11.376002Z] Finished run-tests step (success) 17:53:11 INFO - Running post-run listener: _resource_record_post_run 17:53:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 397492224; Read time: 216; Write time: 338080 17:53:11 INFO - TinderboxPrint: CPU usage
13.1% 17:53:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 17:53:11 INFO - TinderboxPrint: I/O write bytes / time
397,492,224 / 338,080 17:53:11 INFO - TinderboxPrint: CPU idle
8,295.9 (86.9%) 17:53:11 INFO - TinderboxPrint: CPU user
1,198.7 (12.6%) 17:53:11 INFO - TinderboxPrint: Swap in / out
0 / 0 17:53:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108552192; Read time: 0; Write time: 106536 17:53:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288940032; Read time: 196; Write time: 231544 17:53:12 INFO - Running post-run listener: _upload_blobber_files 17:53:12 INFO - Blob upload gear active. 17:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:53:12 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 17:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:53:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:13 INFO - (blobuploader) - INFO - Done attempting. 17:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:17 INFO - (blobuploader) - INFO - Done attempting. 17:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:18 INFO - (blobuploader) - INFO - Done attempting. 17:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:53:18 INFO - Return code: 0 17:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2cc8c7a007118b558a48024497a6e93a86640727aa9966725559700cccb85d32bc94b23e9a03eacab197e4f135d238de2fd3ff5dad8add3831a95b46825a913", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a12cdc88340dfcda498edb78f92116407aec3d33e5e369878ef69630df42004289558007e72218a617d6239279edaf0f2bad2ffeb0788a9e6249b884b13f1f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea8368104c4742c9af5c8ab298e107adc838f02ae84f91c69d4d4e24639fa6a88aad0dd80dd8c74ac0ce99471aa4d7860e57688eff229d017e4a2fbcb9a1f570"} 17:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:53:18 INFO - Contents: 17:53:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2cc8c7a007118b558a48024497a6e93a86640727aa9966725559700cccb85d32bc94b23e9a03eacab197e4f135d238de2fd3ff5dad8add3831a95b46825a913", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a12cdc88340dfcda498edb78f92116407aec3d33e5e369878ef69630df42004289558007e72218a617d6239279edaf0f2bad2ffeb0788a9e6249b884b13f1f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea8368104c4742c9af5c8ab298e107adc838f02ae84f91c69d4d4e24639fa6a88aad0dd80dd8c74ac0ce99471aa4d7860e57688eff229d017e4a2fbcb9a1f570"} 17:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:53:18 INFO - Copying logs to upload dir... 17:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.604416 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 17:53:18.543384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 17:53:18.549301) ========= 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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2cc8c7a007118b558a48024497a6e93a86640727aa9966725559700cccb85d32bc94b23e9a03eacab197e4f135d238de2fd3ff5dad8add3831a95b46825a913", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a12cdc88340dfcda498edb78f92116407aec3d33e5e369878ef69630df42004289558007e72218a617d6239279edaf0f2bad2ffeb0788a9e6249b884b13f1f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea8368104c4742c9af5c8ab298e107adc838f02ae84f91c69d4d4e24639fa6a88aad0dd80dd8c74ac0ce99471aa4d7860e57688eff229d017e4a2fbcb9a1f570"} build_url:https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011535 build_url: 'https://queue.taskcluster.net/v1/task/QzYnmw1UTpeDdq12A0d5Ug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2cc8c7a007118b558a48024497a6e93a86640727aa9966725559700cccb85d32bc94b23e9a03eacab197e4f135d238de2fd3ff5dad8add3831a95b46825a913", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a12cdc88340dfcda498edb78f92116407aec3d33e5e369878ef69630df42004289558007e72218a617d6239279edaf0f2bad2ffeb0788a9e6249b884b13f1f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea8368104c4742c9af5c8ab298e107adc838f02ae84f91c69d4d4e24639fa6a88aad0dd80dd8c74ac0ce99471aa4d7860e57688eff229d017e4a2fbcb9a1f570"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 17:53:18.575574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:53:18.575964) ========= 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=826874ccc97bd7bf541b4875000001d5-1475541155.361350-1693925624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 17:53:18.660504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 17:53:18.661195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 17:53:18.661762) ========= ========= Total master_lag: 0.18 =========