builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1475285368.33 results: success (0) buildid: 20160930153004 builduid: 4324de83c1f34e58ae86790f2a042386 revision: d69d58af9bea7a2781304d3ee3ba2122b2c07abf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.331269) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.331794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.332110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.347264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.347664) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 18:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.4M=0s 2016-09-30 18:29:28 (67.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.487934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.488289) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.540781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:28.541589) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d69d58af9bea7a2781304d3ee3ba2122b2c07abf --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 d69d58af9bea7a2781304d3ee3ba2122b2c07abf --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 18:29:28,902 truncating revision to first 12 chars 2016-09-30 18:29:28,902 Setting DEBUG logging. 2016-09-30 18:29:28,902 attempt 1/10 2016-09-30 18:29:28,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d69d58af9bea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 18:29:29,530 unpacking tar archive at: fx-team-d69d58af9bea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:29.517463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:29.517872) ========= script_repo_revision: d69d58af9bea7a2781304d3ee3ba2122b2c07abf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:29.518320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:29.518636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 18:29:29.529563) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2016-09-30 18:29:29.529885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:29 INFO - MultiFileLogger online at 20160930 18:29:29 in /builds/slave/test 18:29:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:29:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:29 INFO - {'append_to_log': False, 18:29:29 INFO - 'base_work_dir': '/builds/slave/test', 18:29:29 INFO - 'blob_upload_branch': 'Fx-Team', 18:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:29 INFO - 'branch': 'Fx-Team', 18:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:29 INFO - 'config_files': ('talos/linux_config.py',), 18:29:29 INFO - 'default_actions': ('clobber', 18:29:29 INFO - 'read-buildbot-config', 18:29:29 INFO - 'download-and-extract', 18:29:29 INFO - 'populate-webroot', 18:29:29 INFO - 'create-virtualenv', 18:29:29 INFO - 'install', 18:29:29 INFO - 'run-tests'), 18:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:29 INFO - 'download_minidump_stackwalk': True, 18:29:29 INFO - 'download_symbols': 'ondemand', 18:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:29 INFO - 'installer_path': 'installer.exe', 18:29:29 INFO - 'log_level': 'info', 18:29:29 INFO - 'log_name': 'talos', 18:29:29 INFO - 'log_to_console': True, 18:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:29 INFO - 'opt_config_files': (), 18:29:29 INFO - 'pip_index': False, 18:29:29 INFO - 'sps_profile': False, 18:29:29 INFO - 'sps_profile_interval': 0, 18:29:29 INFO - 'suite': 'dromaeojs-e10s', 18:29:29 INFO - 'system_bits': '32', 18:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:29 INFO - 'title': 'talos-linux64-ix-069', 18:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:29 INFO - 'use_talos_json': True, 18:29:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:29 INFO - 'work_dir': 'build'} 18:29:29 INFO - [mozharness: 2016-10-01 01:29:29.986192Z] Running clobber step. 18:29:29 INFO - Running pre-action listener: _resource_record_pre_action 18:29:29 INFO - Running main action method: clobber 18:29:29 INFO - rmtree: /builds/slave/test/build 18:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:30 INFO - Running post-action listener: _resource_record_post_action 18:29:30 INFO - [mozharness: 2016-10-01 01:29:30.440645Z] Finished clobber step (success) 18:29:30 INFO - [mozharness: 2016-10-01 01:29:30.440748Z] Running read-buildbot-config step. 18:29:30 INFO - Running pre-action listener: _resource_record_pre_action 18:29:30 INFO - Running main action method: read_buildbot_config 18:29:30 INFO - Using buildbot properties: 18:29:30 INFO - { 18:29:30 INFO - "project": "", 18:29:30 INFO - "product": "firefox", 18:29:30 INFO - "script_repo_revision": "production", 18:29:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:29:30 INFO - "repository": "", 18:29:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:29:30 INFO - "buildid": "20160930153004", 18:29:30 INFO - "pgo_build": "True", 18:29:30 INFO - "basedir": "/builds/slave/test", 18:29:30 INFO - "buildnumber": 814, 18:29:30 INFO - "slavename": "talos-linux64-ix-069", 18:29:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:29:30 INFO - "platform": "ubuntu64_hw", 18:29:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:29:30 INFO - "branch": "fx-team", 18:29:30 INFO - "repo_path": "integration/fx-team", 18:29:30 INFO - "revision": "d69d58af9bea7a2781304d3ee3ba2122b2c07abf", 18:29:30 INFO - "stage_platform": "linux64-pgo", 18:29:30 INFO - "builduid": "4324de83c1f34e58ae86790f2a042386", 18:29:30 INFO - "slavebuilddir": "test" 18:29:30 INFO - } 18:29:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:29:30 INFO - Running post-action listener: _resource_record_post_action 18:29:30 INFO - [mozharness: 2016-10-01 01:29:30.443191Z] Finished read-buildbot-config step (success) 18:29:30 INFO - [mozharness: 2016-10-01 01:29:30.443278Z] Running download-and-extract step. 18:29:30 INFO - Running pre-action listener: _resource_record_pre_action 18:29:30 INFO - Running main action method: download_and_extract 18:29:30 INFO - mkdir: /builds/slave/test/build/tests 18:29:30 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')]} 18:29:30 INFO - trying https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:29:30 INFO - Downloaded 1361 bytes. 18:29:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:29:31 INFO - Using the following test package requirements: 18:29:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'jsshell-linux-x86_64.zip'], 18:29:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:29:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:31 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:29:31 INFO - Http code: 200 18:29:31 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 18:29:31 INFO - x-amz-cf-id: BGs6iR1f10dI4BVacmlW73OPeGMxjN2abhk-aQwMsqfHUyk4e1y7UQ== 18:29:31 INFO - x-amz-version-id: yV_3HKSV_7ZWTkSzGmkuonIb23HMf5WB 18:29:31 INFO - Expected file size: 21990087 18:29:31 INFO - Obtained file size: 21990087 18:29:35 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 18:29:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:29:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:29:36 INFO - Http code: 200 18:29:36 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:29:36 INFO - x-amz-cf-id: qJONXhvv7I7w-ilLUvt5oHX2nAR1RsrEBazOFGbVGUlt4CwPWzPN5g== 18:29:36 INFO - x-amz-version-id: yV_3HKSV_7ZWTkSzGmkuonIb23HMf5WB 18:29:36 INFO - Expected file size: 21990087 18:29:36 INFO - Obtained file size: 21990087 18:29:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:29:41 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:29:41 INFO - Http code: 200 18:29:41 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:29:41 INFO - x-amz-cf-id: CEh91-V7MEgj4m7oqI0YdCRu-DOlkFvPbZ1fT1h8Z47S3z7le3AMdg== 18:29:41 INFO - x-amz-version-id: 81R2UycUUEOg2alYhzKXkQsIEUk5BNzZ 18:29:41 INFO - Expected file size: 14408522 18:29:41 INFO - Obtained file size: 14408522 18:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:42 INFO - trying https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:42 INFO - Downloading https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:29:43 INFO - Downloaded 59656577 bytes. 18:29:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:43 INFO - mkdir: /builds/slave/test/properties 18:29:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:43 INFO - Contents: 18:29:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:44 INFO - Running post-action listener: _resource_record_post_action 18:29:44 INFO - Running post-action listener: set_extra_try_arguments 18:29:44 INFO - [mozharness: 2016-10-01 01:29:44.004498Z] Finished download-and-extract step (success) 18:29:44 INFO - [mozharness: 2016-10-01 01:29:44.004724Z] Running populate-webroot step. 18:29:44 INFO - Running pre-action listener: _resource_record_pre_action 18:29:44 INFO - Running main action method: populate_webroot 18:29:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:44 INFO - '--tppagecycles', 18:29:44 INFO - '7'], 18:29:44 INFO - 'tests': ['tsvgm']}}, 18:29:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:29:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:29:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['damp', 'tps']}, 18:29:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'tests': ['damp', 'tps']}, 18:29:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['dromaeo_dom']}, 18:29:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['basic_compositor_video']}, 18:29:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:29:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'other-e10s': {'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['a11yr', 18:29:44 INFO - 'ts_paint', 18:29:44 INFO - 'tpaint', 18:29:44 INFO - 'sessionrestore', 18:29:44 INFO - 'sessionrestore_no_auto_restore', 18:29:44 INFO - 'tabpaint']}, 18:29:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['tsvgx', 18:29:44 INFO - 'tsvgr_opacity', 18:29:44 INFO - 'tart', 18:29:44 INFO - 'tscrollx', 18:29:44 INFO - 'cart']}, 18:29:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:29:44 INFO - 'tsvgr_opacity', 18:29:44 INFO - 'tart', 18:29:44 INFO - 'tscrollx', 18:29:44 INFO - 'cart']}, 18:29:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'talos_options': ['--disable-e10s'], 18:29:44 INFO - 'tests': ['tp5o']}, 18:29:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'tests': ['tp5o']}, 18:29:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'talos_options': ['--disable-e10s', 18:29:44 INFO - '--xperf_path', 18:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:44 INFO - 'tests': ['tp5n']}, 18:29:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:44 INFO - 'talos_options': ['--xperf_path', 18:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:44 INFO - 'tests': ['tp5n']}}, 18:29:44 INFO - 'talos.zip': {'path': '', 18:29:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:44 INFO - Running post-action listener: _resource_record_post_action 18:29:44 INFO - [mozharness: 2016-10-01 01:29:44.021576Z] Finished populate-webroot step (success) 18:29:44 INFO - [mozharness: 2016-10-01 01:29:44.021665Z] Running create-virtualenv step. 18:29:44 INFO - Running pre-action listener: _resource_record_pre_action 18:29:44 INFO - Running main action method: create_virtualenv 18:29:44 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:44 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 18:29:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:44 INFO - Using real prefix '/usr' 18:29:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:46 INFO - Installing pip.................done. 18:29:46 INFO - Return code: 0 18:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:29:46 INFO - Reading from file tmpfile_stdout 18:29:46 INFO - Output received: 18:29:46 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) 18:29:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:46 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')]} 18:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:46 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')]} 18:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:46 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:46 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 18:29:46 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 18:29:46 INFO - Using env: {'DISPLAY': ':0', 18:29:46 INFO - 'HOME': '/home/cltbld', 18:29:46 INFO - 'LANG': 'en_US.UTF-8', 18:29:46 INFO - 'LANGUAGE': 'en_US:en', 18:29:46 INFO - 'LOGNAME': 'cltbld', 18:29:46 INFO - 'MAIL': '/var/mail/cltbld', 18:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:46 INFO - 'MOZ_NO_REMOTE': '1', 18:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:46 INFO - 'NO_EM_RESTART': '1', 18:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:46 INFO - 'PWD': '/builds/slave/test', 18:29:46 INFO - 'SHELL': '/bin/bash', 18:29:46 INFO - 'SHLVL': '1', 18:29:46 INFO - 'TERM': 'linux', 18:29:46 INFO - 'TMOUT': '86400', 18:29:46 INFO - 'USER': 'cltbld', 18:29:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:46 INFO - '_': '/tools/buildbot/bin/python'} 18:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:46 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 18:29:46 INFO - Cleaning up... 18:29:47 INFO - Return code: 0 18:29:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:29:47 INFO - Using env: {'DISPLAY': ':0', 18:29:47 INFO - 'HOME': '/home/cltbld', 18:29:47 INFO - 'LANG': 'en_US.UTF-8', 18:29:47 INFO - 'LANGUAGE': 'en_US:en', 18:29:47 INFO - 'LOGNAME': 'cltbld', 18:29:47 INFO - 'MAIL': '/var/mail/cltbld', 18:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:47 INFO - 'MOZ_NO_REMOTE': '1', 18:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:47 INFO - 'NO_EM_RESTART': '1', 18:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:47 INFO - 'PWD': '/builds/slave/test', 18:29:47 INFO - 'SHELL': '/bin/bash', 18:29:47 INFO - 'SHLVL': '1', 18:29:47 INFO - 'TERM': 'linux', 18:29:47 INFO - 'TMOUT': '86400', 18:29:47 INFO - 'USER': 'cltbld', 18:29:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:47 INFO - '_': '/tools/buildbot/bin/python'} 18:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:47 INFO - Downloading/unpacking psutil>=3.1.1 18:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:49 INFO - Installing collected packages: psutil 18:29:49 INFO - Running setup.py install for psutil 18:29:49 INFO - building 'psutil._psutil_linux' extension 18:29:49 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 18:29:49 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 18:29:49 INFO - building 'psutil._psutil_posix' extension 18:29:49 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 18:29:49 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 18:29:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:49 INFO - Successfully installed psutil 18:29:49 INFO - Cleaning up... 18:29:49 INFO - Return code: 0 18:29:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:29:49 INFO - Using env: {'DISPLAY': ':0', 18:29:49 INFO - 'HOME': '/home/cltbld', 18:29:49 INFO - 'LANG': 'en_US.UTF-8', 18:29:49 INFO - 'LANGUAGE': 'en_US:en', 18:29:49 INFO - 'LOGNAME': 'cltbld', 18:29:49 INFO - 'MAIL': '/var/mail/cltbld', 18:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:49 INFO - 'MOZ_NO_REMOTE': '1', 18:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:49 INFO - 'NO_EM_RESTART': '1', 18:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:49 INFO - 'PWD': '/builds/slave/test', 18:29:49 INFO - 'SHELL': '/bin/bash', 18:29:49 INFO - 'SHLVL': '1', 18:29:49 INFO - 'TERM': 'linux', 18:29:49 INFO - 'TMOUT': '86400', 18:29:49 INFO - 'USER': 'cltbld', 18:29:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:49 INFO - '_': '/tools/buildbot/bin/python'} 18:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:29:51 INFO - Installing collected packages: mozsystemmonitor 18:29:51 INFO - Running setup.py install for mozsystemmonitor 18:29:52 INFO - Successfully installed mozsystemmonitor 18:29:52 INFO - Cleaning up... 18:29:52 INFO - Return code: 0 18:29:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:29:52 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')]} 18:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:52 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')]} 18:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:52 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:52 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 18:29:52 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 18:29:52 INFO - Using env: {'DISPLAY': ':0', 18:29:52 INFO - 'HOME': '/home/cltbld', 18:29:52 INFO - 'LANG': 'en_US.UTF-8', 18:29:52 INFO - 'LANGUAGE': 'en_US:en', 18:29:52 INFO - 'LOGNAME': 'cltbld', 18:29:52 INFO - 'MAIL': '/var/mail/cltbld', 18:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:52 INFO - 'MOZ_NO_REMOTE': '1', 18:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:52 INFO - 'NO_EM_RESTART': '1', 18:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:52 INFO - 'PWD': '/builds/slave/test', 18:29:52 INFO - 'SHELL': '/bin/bash', 18:29:52 INFO - 'SHLVL': '1', 18:29:52 INFO - 'TERM': 'linux', 18:29:52 INFO - 'TMOUT': '86400', 18:29:52 INFO - 'USER': 'cltbld', 18:29:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:52 INFO - '_': '/tools/buildbot/bin/python'} 18:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:52 INFO - Downloading/unpacking jsonschema==2.5.1 18:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:29:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:29:54 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 18:29:54 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 18:29:54 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 18:29:54 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 18:29:54 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 18:29:54 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 18:29:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:29:54 INFO - warning: no files found matching '*.txt' 18:29:54 INFO - no previously-included directories found matching 'build' 18:29:54 INFO - no previously-included directories found matching 'dist' 18:29:54 INFO - no previously-included directories found matching '.git*' 18:29:54 INFO - Installing collected packages: jsonschema, functools32 18:29:54 INFO - Running setup.py install for functools32 18:29:54 INFO - warning: no files found matching '*.txt' 18:29:54 INFO - no previously-included directories found matching 'build' 18:29:54 INFO - no previously-included directories found matching 'dist' 18:29:54 INFO - no previously-included directories found matching '.git*' 18:29:54 INFO - Successfully installed jsonschema functools32 18:29:54 INFO - Cleaning up... 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:29:54 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')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:54 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 18:29:54 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 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:29:54 INFO - Cleaning up... 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29:54 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')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:54 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 18:29:54 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 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:29:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:29:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 INFO - Downloading docopt-0.6.1.tar.gz 18:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:29:57 INFO - Running setup.py install for blobuploader 18:29:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:29:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:29:57 INFO - Running setup.py install for requests 18:29:58 INFO - Running setup.py install for docopt 18:29:58 INFO - Successfully installed blobuploader requests docopt 18:29:58 INFO - Cleaning up... 18:29:58 INFO - Return code: 0 18:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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')]} 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:58 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:29:58 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 18:29:58 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 18:29:58 INFO - Using env: {'DISPLAY': ':0', 18:29:58 INFO - 'HOME': '/home/cltbld', 18:29:58 INFO - 'LANG': 'en_US.UTF-8', 18:29:58 INFO - 'LANGUAGE': 'en_US:en', 18:29:58 INFO - 'LOGNAME': 'cltbld', 18:29:58 INFO - 'MAIL': '/var/mail/cltbld', 18:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:58 INFO - 'MOZ_NO_REMOTE': '1', 18:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:58 INFO - 'NO_EM_RESTART': '1', 18:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:58 INFO - 'PWD': '/builds/slave/test', 18:29:58 INFO - 'SHELL': '/bin/bash', 18:29:58 INFO - 'SHLVL': '1', 18:29:58 INFO - 'TERM': 'linux', 18:29:58 INFO - 'TMOUT': '86400', 18:29:58 INFO - 'USER': 'cltbld', 18:29:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:58 INFO - '_': '/tools/buildbot/bin/python'} 18:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:58 INFO - Running setup.py (path:/tmp/pip-lBDDMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:58 INFO - Running setup.py (path:/tmp/pip-KmHt8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:58 INFO - Running setup.py (path:/tmp/pip-kCuz_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:58 INFO - Running setup.py (path:/tmp/pip-Rt5o3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:58 INFO - Running setup.py (path:/tmp/pip-YDsAav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:58 INFO - Running setup.py (path:/tmp/pip-g0Dl4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:59 INFO - Running setup.py (path:/tmp/pip-p06wAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:59 INFO - Running setup.py (path:/tmp/pip-mFrvQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:59 INFO - Running setup.py (path:/tmp/pip-KEudzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:59 INFO - Running setup.py (path:/tmp/pip-I_mQ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:59 INFO - Running setup.py (path:/tmp/pip-A7Slwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:59 INFO - Running setup.py (path:/tmp/pip-ymwuxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:59 INFO - Running setup.py (path:/tmp/pip-f6k3Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:59 INFO - Running setup.py (path:/tmp/pip-LQVU61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:59 INFO - Running setup.py (path:/tmp/pip-KV8LvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:59 INFO - Running setup.py (path:/tmp/pip-yRHgnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:59 INFO - Running setup.py (path:/tmp/pip-dBlzo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:29:59 INFO - Running setup.py install for manifestparser 18:29:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:29:59 INFO - Running setup.py install for mozcrash 18:30:00 INFO - Running setup.py install for mozdebug 18:30:00 INFO - Running setup.py install for mozdevice 18:30:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for mozfile 18:30:00 INFO - Running setup.py install for mozhttpd 18:30:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for mozinfo 18:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for mozInstall 18:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for mozleak 18:30:00 INFO - Running setup.py install for mozlog 18:30:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for moznetwork 18:30:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:00 INFO - Running setup.py install for mozprocess 18:30:01 INFO - Running setup.py install for mozprofile 18:30:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:01 INFO - Running setup.py install for mozrunner 18:30:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:01 INFO - Running setup.py install for mozscreenshot 18:30:01 INFO - Running setup.py install for moztest 18:30:01 INFO - Running setup.py install for mozversion 18:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:01 INFO - Cleaning up... 18:30:01 INFO - Return code: 0 18:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:01 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')]} 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:01 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')]} 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:01 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:30:01 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 18:30:01 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 18:30:01 INFO - Using env: {'DISPLAY': ':0', 18:30:01 INFO - 'HOME': '/home/cltbld', 18:30:01 INFO - 'LANG': 'en_US.UTF-8', 18:30:01 INFO - 'LANGUAGE': 'en_US:en', 18:30:01 INFO - 'LOGNAME': 'cltbld', 18:30:01 INFO - 'MAIL': '/var/mail/cltbld', 18:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:01 INFO - 'MOZ_NO_REMOTE': '1', 18:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:01 INFO - 'NO_EM_RESTART': '1', 18:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:01 INFO - 'PWD': '/builds/slave/test', 18:30:01 INFO - 'SHELL': '/bin/bash', 18:30:01 INFO - 'SHLVL': '1', 18:30:01 INFO - 'TERM': 'linux', 18:30:01 INFO - 'TMOUT': '86400', 18:30:01 INFO - 'USER': 'cltbld', 18:30:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:01 INFO - '_': '/tools/buildbot/bin/python'} 18:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:01 INFO - Running setup.py (path:/tmp/pip-wjmU44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:01 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)) 18:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:01 INFO - Running setup.py (path:/tmp/pip-w5v3ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:02 INFO - Running setup.py (path:/tmp/pip-9DfCnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:02 INFO - Running setup.py (path:/tmp/pip-8j1A_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:02 INFO - Running setup.py (path:/tmp/pip-plb8eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:02 INFO - Running setup.py (path:/tmp/pip-h8d8O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:02 INFO - Running setup.py (path:/tmp/pip-VQCYfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:02 INFO - Running setup.py (path:/tmp/pip-niK9fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:02 INFO - Running setup.py (path:/tmp/pip-nXMAjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:02 INFO - Running setup.py (path:/tmp/pip-tcTiUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:02 INFO - Running setup.py (path:/tmp/pip-5XrUx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:02 INFO - Running setup.py (path:/tmp/pip-9PfCfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:02 INFO - Running setup.py (path:/tmp/pip-RuwL07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:02 INFO - Running setup.py (path:/tmp/pip-BCGjxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:02 INFO - Running setup.py (path:/tmp/pip-m5ljSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:02 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)) 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:02 INFO - Running setup.py (path:/tmp/pip-rZRXKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:03 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)) 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:03 INFO - Running setup.py (path:/tmp/pip-4wvqqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:03 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)) 18:30:03 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)) 18:30:03 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)) 18:30:03 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)) 18:30:03 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)) 18:30:03 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)) 18:30:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:04 INFO - Downloading blessings-1.6.tar.gz 18:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:05 INFO - Installing collected packages: blessings 18:30:05 INFO - Running setup.py install for blessings 18:30:05 INFO - Successfully installed blessings 18:30:05 INFO - Cleaning up... 18:30:05 INFO - Return code: 0 18:30:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:05 INFO - Reading from file tmpfile_stdout 18:30:05 INFO - Current package versions: 18:30:05 INFO - argparse == 1.2.1 18:30:05 INFO - blessings == 1.6 18:30:05 INFO - blobuploader == 1.2.4 18:30:05 INFO - docopt == 0.6.1 18:30:05 INFO - functools32 == 3.2.3-2 18:30:05 INFO - jsonschema == 2.5.1 18:30:05 INFO - manifestparser == 1.1 18:30:05 INFO - mozInstall == 1.12 18:30:05 INFO - mozcrash == 0.17 18:30:05 INFO - mozdebug == 0.1 18:30:05 INFO - mozdevice == 0.48 18:30:05 INFO - mozfile == 1.2 18:30:05 INFO - mozhttpd == 0.7 18:30:05 INFO - mozinfo == 0.9 18:30:05 INFO - mozleak == 0.1 18:30:05 INFO - mozlog == 3.4 18:30:05 INFO - moznetwork == 0.27 18:30:05 INFO - mozprocess == 0.23 18:30:05 INFO - mozprofile == 0.28 18:30:05 INFO - mozrunner == 6.12 18:30:05 INFO - mozscreenshot == 0.1 18:30:05 INFO - mozsystemmonitor == 0.3 18:30:05 INFO - moztest == 0.7 18:30:05 INFO - mozversion == 1.4 18:30:05 INFO - psutil == 3.1.1 18:30:05 INFO - requests == 1.2.3 18:30:05 INFO - wsgiref == 0.1.2 18:30:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:05 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')]} 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 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')]} 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:30:05 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 18:30:05 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 18:30:05 INFO - Using env: {'DISPLAY': ':0', 18:30:05 INFO - 'HOME': '/home/cltbld', 18:30:05 INFO - 'LANG': 'en_US.UTF-8', 18:30:05 INFO - 'LANGUAGE': 'en_US:en', 18:30:05 INFO - 'LOGNAME': 'cltbld', 18:30:05 INFO - 'MAIL': '/var/mail/cltbld', 18:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:05 INFO - 'MOZ_NO_REMOTE': '1', 18:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:05 INFO - 'NO_EM_RESTART': '1', 18:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:05 INFO - 'PWD': '/builds/slave/test', 18:30:05 INFO - 'SHELL': '/bin/bash', 18:30:05 INFO - 'SHLVL': '1', 18:30:05 INFO - 'TERM': 'linux', 18:30:05 INFO - 'TMOUT': '86400', 18:30:05 INFO - 'USER': 'cltbld', 18:30:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:05 INFO - '_': '/tools/buildbot/bin/python'} 18:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 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)) 18:30:05 INFO - Cleaning up... 18:30:05 INFO - Return code: 0 18:30:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:05 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')]} 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 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')]} 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 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 0x7f4e410b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', '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 18:30:05 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 18:30:05 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 18:30:05 INFO - Using env: {'DISPLAY': ':0', 18:30:05 INFO - 'HOME': '/home/cltbld', 18:30:05 INFO - 'LANG': 'en_US.UTF-8', 18:30:05 INFO - 'LANGUAGE': 'en_US:en', 18:30:05 INFO - 'LOGNAME': 'cltbld', 18:30:05 INFO - 'MAIL': '/var/mail/cltbld', 18:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:05 INFO - 'MOZ_NO_REMOTE': '1', 18:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:05 INFO - 'NO_EM_RESTART': '1', 18:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:05 INFO - 'PWD': '/builds/slave/test', 18:30:05 INFO - 'SHELL': '/bin/bash', 18:30:05 INFO - 'SHLVL': '1', 18:30:05 INFO - 'TERM': 'linux', 18:30:05 INFO - 'TMOUT': '86400', 18:30:05 INFO - 'USER': 'cltbld', 18:30:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:05 INFO - '_': '/tools/buildbot/bin/python'} 18:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:05 INFO - Cleaning up... 18:30:05 INFO - Return code: 0 18:30:05 INFO - Running post-action listener: _resource_record_post_action 18:30:05 INFO - Running post-action listener: _start_resource_monitoring 18:30:05 INFO - Starting resource monitoring. 18:30:05 INFO - [mozharness: 2016-10-01 01:30:05.961976Z] Finished create-virtualenv step (success) 18:30:05 INFO - [mozharness: 2016-10-01 01:30:05.962524Z] Running install step. 18:30:05 INFO - Running pre-action listener: _resource_record_pre_action 18:30:05 INFO - Running main action method: install 18:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:06 INFO - Reading from file tmpfile_stdout 18:30:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:06 INFO - Reading from file tmpfile_stdout 18:30:06 INFO - Output received: 18:30:06 INFO - Usage: mozinstall [options] installer 18:30:06 INFO - Options: 18:30:06 INFO - -h, --help show this help message and exit 18:30:06 INFO - -d DEST, --destination=DEST 18:30:06 INFO - Directory to install application into. [default: 18:30:06 INFO - "/builds/slave/test"] 18:30:06 INFO - --app=APP Application being installed. [default: firefox] 18:30:06 INFO - mkdir: /builds/slave/test/build/application 18:30:06 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'] 18:30:06 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 18:30:23 INFO - Reading from file tmpfile_stdout 18:30:23 INFO - Output received: 18:30:23 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:23 INFO - Running post-action listener: _resource_record_post_action 18:30:23 INFO - [mozharness: 2016-10-01 01:30:23.259826Z] Finished install step (success) 18:30:23 INFO - [mozharness: 2016-10-01 01:30:23.260071Z] Running run-tests step. 18:30:23 INFO - Running pre-action listener: _resource_record_pre_action 18:30:23 INFO - Running main action method: run_tests 18:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:23 INFO - Python 2.7.3 18:30:23 INFO - Return code: 0 18:30:23 INFO - grabbing minidump binary from tooltool 18:30:23 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')]} 18:30:23 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 0x1dea790>, '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 0x1deb690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1debb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:23 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 18:30:23 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 18:30:23 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 18:30:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:23 INFO - Return code: 0 18:30:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:30:23 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:30:23 INFO - Using env: {'DISPLAY': ':0', 18:30:23 INFO - 'HOME': '/home/cltbld', 18:30:23 INFO - 'LANG': 'en_US.UTF-8', 18:30:23 INFO - 'LANGUAGE': 'en_US:en', 18:30:23 INFO - 'LOGNAME': 'cltbld', 18:30:23 INFO - 'MAIL': '/var/mail/cltbld', 18:30:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:23 INFO - 'MOZ_NO_REMOTE': '1', 18:30:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:23 INFO - 'NO_EM_RESTART': '1', 18:30:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:23 INFO - 'PWD': '/builds/slave/test', 18:30:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:23 INFO - 'SHELL': '/bin/bash', 18:30:23 INFO - 'SHLVL': '1', 18:30:23 INFO - 'TERM': 'linux', 18:30:23 INFO - 'TMOUT': '86400', 18:30:23 INFO - 'USER': 'cltbld', 18:30:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474', 18:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:23 INFO - '_': '/tools/buildbot/bin/python'} 18:30:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:30:23 INFO - mozversion application_buildid: 20160930153004 18:30:23 INFO - mozversion application_changeset: d69d58af9bea7a2781304d3ee3ba2122b2c07abf 18:30:23 INFO - mozversion application_display_name: Nightly 18:30:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:23 INFO - mozversion application_name: Firefox 18:30:23 INFO - mozversion application_remotingname: firefox 18:30:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:30:23 INFO - mozversion application_vendor: Mozilla 18:30:23 INFO - mozversion application_version: 52.0a1 18:30:23 INFO - mozversion platform_buildid: 20160930153004 18:30:23 INFO - mozversion platform_changeset: d69d58af9bea7a2781304d3ee3ba2122b2c07abf 18:30:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:30:23 INFO - mozversion platform_version: 52.0a1 18:30:23 INFO - using testdate: 1475285423 18:30:23 INFO - actual date: 1475285423 18:30:23 INFO - starting webserver on 'localhost:57344' 18:30:23 INFO - SUITE-START | Running 2 tests 18:30:23 INFO - TEST-START | dromaeo_css 18:30:23 INFO - operating with platform_type : linux_ 18:30:23 INFO - Initialising browser for dromaeo_css test... 18:30:23 INFO - TEST-INFO | started process 15507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHql2v/profile http://localhost:57344/getInfo.html) 18:30:28 INFO - PROCESS | 15507 | __metrics Screen width/height:1600/1200 18:30:28 INFO - PROCESS | 15507 | colorDepth:24 18:30:28 INFO - PROCESS | 15507 | Browser inner width/height: 1024/697 18:30:28 INFO - PROCESS | 15507 | __metrics 18:30:28 ERROR - PROCESS | 15507 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 18:30:29 INFO - TEST-INFO | 15507: exit 0 18:30:29 INFO - Browser initialized. 18:30:29 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:29 INFO - TEST-INFO | started process 15626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHql2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:41 INFO - PROCESS | 15626 | RSS: Main: 185376768 18:30:41 INFO - PROCESS | 15626 | 18:31:31 INFO - PROCESS | 15626 | 1475285491387 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] 18:33:40 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57344/tests/dromaeo/cssquery-ext.html) 18:33:41 INFO - PROCESS | 15626 | RSS: Main: 202731520 18:33:41 INFO - PROCESS | 15626 | 18:36:44 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-ext.html (next: http://localhost:57344/tests/dromaeo/cssquery-jquery.html) 18:36:44 INFO - PROCESS | 15626 | RSS: Main: 200650752 18:36:44 INFO - PROCESS | 15626 | 18:39:46 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57344/tests/dromaeo/cssquery-mootools.html) 18:39:47 INFO - PROCESS | 15626 | RSS: Main: 198651904 18:39:47 INFO - PROCESS | 15626 | 18:42:49 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57344/tests/dromaeo/cssquery-prototype.html) 18:42:49 INFO - PROCESS | 15626 | RSS: Main: 195256320 18:42:49 INFO - PROCESS | 15626 | 18:45:52 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57344/tests/dromaeo/cssquery-yui.html) 18:45:53 INFO - PROCESS | 15626 | RSS: Main: 199380992 18:45:53 INFO - PROCESS | 15626 | 18:48:55 INFO - PROCESS | 15626 | Cycle 1(1): loaded http://localhost:57344/tests/dromaeo/cssquery-yui.html (next: http://localhost:57344/tests/dromaeo/cssquery-dojo.html) 18:48:56 INFO - PROCESS | 15626 | RSS: Main: 199806976 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | __start_tp_report 18:48:56 INFO - PROCESS | 15626 | _x_x_mozilla_page_load 18:48:56 INFO - PROCESS | 15626 | _x_x_mozilla_page_load_details 18:48:56 INFO - PROCESS | 15626 | |i|pagename|runs| 18:48:56 INFO - PROCESS | 15626 | |0;dojo.html;2926.61953945987;2988.103568929321;2992.3566433216856;3025;3033.9089827305174;5219.217117432382;5275.261463395128;5322.2814919985885;5323.866903327414;5362.490563396481;5298.178782288752;5333.146696528556;5348.304720386344;5384.030874442598;5400.729963501819;4798.520147985199;4903.754812259391;4922.163232250508;4953.578945789613;4958.603311735071;4979.278004689318;4992;5007.799688012475;5026.748662566875;5035.420926593452;4733.100710864959;4777.8327758528285;4823.5658790709;4919.434265059528;4981.203007518798;4862.513748625144;4874.805007799684;4891.1685013547785;4934.851954441372;4947.90104197914;4799.18413869643;4841.588464980481;4846.7818948147415;4863.10032643962;4872.805087796484;5140.074786538422;5158.0199762045095;5274.868128296824;5305.0450918834595;5401.945980540184;5623.8594035149035;5646.040173170571;5669.206311116447;5672.659640421547;5674.205611214434;5670.3479099903625;5677.233573467571;5760.510356619692;5768.596198266123;5775.624584402;5351.357837059578;5362.490563396432;5367.785288588452;5368.711509237833;5386.165144402624;5865.4134586541;5865.472107510259;5866.354700982888;5869.706514674249;5929.6145750526075;5568.916466253009;5637.577181711388;5642.492175704124;5642.943570564242;5643.040683083804;5509.862253443696;5624.184493248456;5675.262215911905;5733.254676891977;5734.770609175586;5660;5661.34894487131;5668.943310566841;5704.001799685038;5715.114157305624;5651.576131790132;5654.123610840326;5654.802081927113;5657.066584013592;5663.745131469093;4353.412289340962;4414.735115893057;4424.73451592899;4428.933565996513;4496.820127194941;3913.8630147944687;3953.2093581283284;4004.9199016020098;4020.3366444536323;4022.8591999279884;5401.702906340189;5491.28613280271;5510.201020851954;5516.889662206733;5519.172124181405;5599.384067752544;5677.37548869624;5745.368009518949;5754.482096611325;5763.106718458645;5388.676679399248;5415.891682166334;5419.783208671609;5440.483154100354;5492.835214943558;4965.677230980047;4991;4993.101241776515;4996.625253106032;5062.443131255559;5878.2358293421585;5898.469137777621;5955.196048533479;5956.791512297049;5964.433378829004;5658.971705141613;5683.318001839806;5722.141678748221;5725.370209276893;5789;5976.372480889444;5977.103434484862;5987.910181347371;5992.610480318765;6004.1294012368835;5520.558355331644;5560.833175004756;5605.5515558756015;5614.522765564972;5639.830805075854;5694.629849059798;5733.483986441241;5747.568932330176;5769.278840144982;5794.768209271582;5622.409646987007;5633;5636.492715655447;5637.746301416528;5638.041532939328;5439.782408703608;5619.100943848965;5624.072028115315;5627.915581266202;5631.070873305859;5394.622376433612;5447.128459446628;5458.4541545845095;5491.039068162976;5492.395836457907;5540.972295138498;5557.694326811902;5597.412271711574;5605.719714014202;5606.775728970959;5486.396496385315;5487.934766993167;5488.313960754906;5493.670379777226;5560.249366335493 18:48:56 INFO - PROCESS | 15626 | |1;ext.html;576.2451188942485;579.6000759475959;589.7935722497126;593.7476572456707;595.6515438468496;41637.79181104094;43883.12233755323;44074.33888491671;46393;46691.299630505484;44274;44640.3303950441;44808.55191448093;44993.550064499344;45051;8743.431676940978;8920.107989201093;8962.148595883413;8969.461832290051;8974.23718983884;8819.294456443502;8840.778980525507;8915.1976322131;8934;8934.329925255599;8864.778380540505;8937.687180948667;8956.19394254517;8964.551772411385;8977.416467929595;8850.114988501162;8902.510361930124;8902.73291801247;8915.108489151098;8919.108089191093;8726.52004139772;8781.473111613324;8786.64853405863;8815.162559556831;8833.028366879638;42547;42994.14011719748;43075.784621076695;43084.138317233796;43139.78430107861;3386.255023894739;3645.6536629020466;3744.0826997385543;3756.906077348061;4165.895852603679;31340.21649458759;32168.356632867446;32204;32617.596624455633;33051.6694833051;3633.7274704397278;3648.5986541480415;3726.5528136623507;3735.178260782651;3849.30712471755;322405;323259;324136;325215;325425;34252.314953700785;35404.29191416157;58308;58333;58333.708331458074;37727.62272377241;37742.8112859434;37769.24461510754;37842.81078594589;37896.431553526716;13740.65648358799;13876.930615346859;14090.506832260822;14101.365438555289;14118.223497707724;10608.204384671026;10698.144148468104;10700;10708.732281692864;10723.19576031785;8514.318854491627;8548.957255213683;8606.698765543177;8635.611397487128;8700.738977830675;3311.089450401159;3336.099253201622;3337.682920122633;3389.3561622613015;3428.8971330860113;1022.6420752736632;1049.391908662199;1100.3702691284911;1106.9723256918642;1122.859642544682;31819.363612727615;31996;32016.839915800272;32285.35429291448;32404.351912961607;1066.7919755647574;1089.1232557791054;1168.7311918258847;1169.0764296206073;1213.2962881528692;16140.354385824436;16663.583410414838;16751.246193921303;16848.410305639245;17014.404495842587;508712;509538;515850;519594;519857;56751;57550.7122464385;57587;57763.71118144466;57861.710691447115;1294.5339677716015;1333.4732780551822;1349.2646507653353;1350.3855745635713;1357;29880;31330.68669313278;31397.686023139475;31571;32181.839090804395;51505.742471287405;51882.481175187764;52071;52099.21851172311;52136.21795672992;398888;402349;403464;404385;405076;28804.567931481462;28930.85534572398;29010.27474313159;29022.564661529672;29072.27319317034;47349.196358211564;47507.28739068986;48203.517964819905;48700.75649621729;48758.268625969926;39877;40554;41967.790161049;42227.788861055495;42803.35794963016;40474.1905161901;40506;41072.79463602663;41959.790201048796;42353.78823105988;40054.1989160221;40778;41393.37909931293;41443.37834932539;41846.790766045975;34467.827660861534;34558.308833823685;37830.62169378271;38201;38909.221815564095;28399.71600283971;28598.428031438838;28759;29060.854695726386;29124.708752913048 18:48:56 INFO - PROCESS | 15626 | |2;jquery.html;385.1161584164344;385.3641491538962;399.09405649176364;402.73620778390153;421.572104314121;16962.3215071397;17338.56653583661;17672.20475078621;19267.614647707036;19357.225710971543;12485.188462749938;12733.236005839655;12746.490140394373;15432.922835385807;19068.237270509162;5097.108006098927;5306.628536002481;5307.071262529062;5314.123169676998;5317.468253174671;4476.2390393632995;5706.229658996044;5752.597318187729;5760.827175184731;5764.308283006045;5478.671279723229;5699.886002279952;5709.800156994506;5710.257666503348;5714.342850572196;5554.222408862763;5565.6104072714925;5632.915506267409;5633.211350410946;5641.351244606861;4906.558409743105;4928.408590969071;4978.203487442028;5039.546440820307;5042.268871013719;13833.654158646013;13990.020698551105;14019.64950876226;14063.226522541256;14114.85885141156;2320.1647406933657;2329.208069256444;2362.444825466014;2379.988100059506;2804.5652923796843;9566.282528810367;9763.218942484584;10220.335678180894;10418.531166097468;10462.581496740122;1850.2321536562445;1876.859235557325;1882.265916292647;1906.3804263614243;1960.892150931698;80980.59509702414;81559.5922020386;81877.18122818755;82462;82816.58591707062;10930.836037459445;11073.5570577176;11117.555297787998;11150.21948463616;11182.720431989266;15224.923875380553;15278.31247593861;15288.082715037133;15301;15309.540713778604;7388.445866559922;7539.32146106853;7600.543967361976;7856.057273127261;7897.289243968071;7129.750458734024;7150.713971441084;7368.115826100902;7378.1515125761225;7430.182679905206;4510.233260345683;4588.128255631486;4615.538446155425;4736.739479328601;4820.4456487504385;1845.508563439346;1868.2060124447055;1870.326682394337;1870.8596855235912;1895.2608482691762;944.9716508504756;989.4656885281867;998.4558415663481;1018.180364806338;1068.983965240522;17364.91317543404;18152.45542633723;18329.633407331778;18880.811191887904;19160.52098697516;965.8937516873139;978.105033893979;989.8020395920701;1011.595361855249;1014.3406785589426;10212.234082443847;10237.692869213935;10278.897211027943;10881.292715973437;10900.582924219801;326290;327004;397248;430360;434585;93306.53346733224;95315.99999999862;95481.5225923866;96585;97692;1008.8335424654997;1020.4183615339185;1054.8154073037188;1067.3435836960368;1067.5462928255615;16442.83557164413;16852.57868553296;17267;17653;17929.282828687228;41535.7923210382;41573.37639935343;41880;42235.577644223165;42374.152516950104;59186;59259;59389.70305148447;59492.70253648704;59904;8043.477173983672;8050.919490805251;8115.472494287852;8255.42212045151;8323.12607176262;11480.311181329147;12804.359782011048;12877.742445150858;12994.80507792365;13183.67040823987;10708.89291107079;10975.945120274348;11029.61396351124;11094.500747466545;11546.884531154918;10904.727381815517;11035.503402347074;11167.38579378142;11322.207445478738;11390.886091138982;10813.62152324665;10866.836997444887;11192.888071119185;11671.12466564994;12018.699532511757;7067.151941767021;7718.729844455417;8480.321574274167;8646.78383040429;8677.6095075723;10562.577496900038;11092.778144436905;11213.943930280622;11296.378699171624;11538.480768365276 18:48:56 INFO - PROCESS | 15626 | |3;mootools.html;1451.0858159359602;1500.8574185452383;1618.8866779325444;1732.5841797968483;1770.1680210301154;7851.528908265508;8091.3526917846575;8540.914590854098;9187.540622968858;9207.585658645361;8617.56912154393;8915.153060459246;8922.732318030454;9057.50183739894;9069.455832650046;2334.509752951882;2346.7301260355107;2367.810575153992;2369.9407514812183;2371.9407014824683;2258.390234636647;2304.412374844412;2307.3193407944614;2308.5382923415386;2325.8953347099336;2317.455397981473;2329.7204335479682;2340.6840076589615;2353.6587194856734;2365.6215005599106;2245.865248085112;2256.5035692147703;2258.469259723972;2259.9322020339414;2263.2305016294376;2208.6907832903407;2235.9888200558894;2236.787505187021;2237.463008877874;2253.8196944244423;8982.86525702115;9043.050479699603;9054.909450905472;9061.682841100595;9102.04428535001;5018.899622007576;5254.133068043769;5255.842324730226;5260;5263.210518422229;3161.604799400075;3171.1279398165457;3354.983225083859;3362.8150451725146;3375.6961873431264;1028.5731272884009;1085.79369919715;1092.071739021833;1113.8774734779167;1114.921955463118;12336.074794390457;12426.937865310616;12450.81323780144;12467;12480;4384.254676704968;4586.472555656075;4655.953440465552;4701.106789710013;4702;10510.842337364946;10532.420716860646;10560;10581.100606448537;10593.682189534326;5167.431582525919;5174.741262936838;5175.197844334134;5180.507851754077;5186.481351864859;4145.709800314009;4260.403543503912;4521.253993091103;4613.469451013109;4699.530046995342;3872.6901847852105;3894.123822139996;3980.1641655252142;4021.4973128358956;4114.341705327193;1269.206745783885;1286.7297867447753;1292.095533126815;1298.8506321773118;1311.1805121798875;923.1276443760715;943.9103285187896;950.5057370167474;957.8036502516967;969.2149359019216;5788;5834.854128646818;5894.440028197314;5960.195373624592;6091.908621370594;939.2392162348519;1019.938803671782;1046.3094357723867;1047.5966752800227;1076.7254350140663;3910.687145028448;4127.525334586501;4175.227582897173;4215.072684009513;4220.177065472203;10925.508352124174;11123.443827808576;11203.94398028021;11210.495527701272;11237.662870113909;11012.898710128922;11029.503672334764;11055.834162487568;11106.61126860556;11112.833307500232;7609.619519024137;7939.364850811921;8363.665453381918;8409;8441.704540341181;6025.246844144482;6283.465905398092;6293.937060629335;6428.903566446414;6475.061116138039;9991.150752186146;10062.748431289276;10238.846417303896;10252.58989640406;10380.48097595102;10377.11794497446;10585.100266477435;10779.083777878654;10811.243212975016;10815.134789216687;7003.7548685795755;7244.529105608119;7635.083789945242;7787.10448298453;7868.25251601097;8435.24082832548;8746.868796968178;8813.867791983253;8820.2061814437;8838.02781694026;7762.68949242024;7859.214078592095;7888.48724832884;8044.115147333906;8104.392170587347;7678.5392876427595;7832.647530861011;7847.646855891613;7872;7906.407019473448;7256.600886951268;7388.519746216479;7402.518836275625;7403.5928023959195;7409.777706668809;4874.439439464365;4969.155243608668;4989.700617962933;5027.371578552681;5288.550473209666;5006.824761133343;5039.521245481674;5382.7308634567335;5384.6499977501335;5488.780448782004 18:48:56 INFO - PROCESS | 15626 | |4;prototype.html;324.2331885091758;324.4500571531254;333.4714477553079;342.23851929456947;344.4729563767435;5369.9463005369935;5407.594430417715;5421.430749771272;5424.349078110622;5425.864353391167;5302.469753024696;5304.1965731651235;5347.786088556453;5362.892742145154;5412.269343638608;3927.430522574225;4165.291900376943;4209.200251952119;4269.530351661315;4273.508546517143;4178.958210417903;4179.728317659357;4186.413902053715;4202.180574787918;4242.321228603424;4125.773082480462;4166.625003749662;4187.28816101262;4192.5807419258135;4194.867385805831;4005.6995725320426;4118.032262418329;4139.855105071339;4154.50145982484;4155.4805649293685;3650.7444478886487;3654.086478380405;3657.963420365789;3668.559772827251;3682.963170368289;5269.262303277545;5280.683159010472;5291.126964050927;5292.814751483718;5307.336582927134;4580.9541904580865;4755.9286610700865;4761.500042495522;4777.593904518086;4790.6886052406835;5538.944610553883;5547.694876781816;5548.9722551386985;5555.861103472405;5572.888542229173;4022.5374081980654;4024.839006439739;4025.1547175093265;4028.879133625996;4046.271671099201;5647.407022262644;5774.884502309972;5801.187833703285;5806.709664516799;5855.824325270206;4111.342185250345;4125.546189919107;4130.91738165241;4155.812988415529;4157.314043182841;4200.60094291048;4217.304144816071;4217.557156498585;4220.894477638022;4229.746215227096;4667.806606695922;4783.330333753277;4791.664583479123;4796.856094317176;4819.469858315582;5551.333839939233;5569.415211402826;5575.135853942565;5586.972065139729;5630.324361076697;1429.7212043651596;1441.509886638527;1447.8117844680123;1458.562431270636;1461.9561413157621;865.1219012702112;915.9633614655472;921.5254144115786;939.4879790514186;947.9336446448821;4827.069172331096;4829.9275510867365;4839.765859705823;4855.174620314555;4879.560839524389;5009.949900500948;5052.418971818214;5054.927479733292;5096.770645320969;5135.281060651437;4675.812967481331;4864.708117512961;4874.341963834908;4881.51184881509;4888.7311197884455;2719.8440662718267;2721.5917612357907;2731;2733.658292713411;2736.4390299988454;5228.764705588258;5259.921101183485;5291.867703307448;5302.39022512416;5366.290023538167;4901.975490122527;5092.719900405439;5123.795048198031;5201.349831271091;5224.544464101866;5255.369355677343;5303.549198318186;5305.681659100389;5340.332458442695;5342.679439233659;5086.21163719624;5130.923036154386;5134;5147.4557632710785;5168.58651307887;4662.603678687349;4917.877053073702;4954.529319714621;4978.47725988766;5031.874203144951;5222.381061870832;5234.205201229079;5272.499112584298;5291.491924801413;5305.400353826674;3739.8317075732202;3744.876537038823;3758.3275442427857;3763.284975854579;3789.583145854009;4963.4540200577185;5019.598432125495;5025.597952163891;5031.4213865405945;5124.15530409045;4902.509749025212;4905.337779399735;4928.433230178575;4931.827386041471;4938.901221975612;4901.754912254301;4929.457759646508;4939.0243902439315;4962.801487940442;4974.502549744997;4607.815687372467;4920.597629675525;4934;4935.2973224237585;4950.282209079592;4999.900002000012;5375.784968601212;5554.583406244467;5639.464250896158;5684.459976302244;5535.232383808096;5575.1915972184615;5623.325200975909;5627.606067575231;5640.605157638925 18:48:56 INFO - PROCESS | 15626 | |5;yui.html;670.2191946382463;747.6037700018989;761.299604363985;764.2624867003341;768.043785487068;14583.562493125197;15641.374345026214;15760.133192674428;15776.211189440524;15892.761608575865;13569.592912212625;13988.230647314394;14221.573352799407;14276.214808185545;14308;794.1383598795314;809.9676012959475;812.1229072601606;812.175641723648;812.2364976921705;778.5990215039259;808.7735434078438;816.967321307147;817.1256755271861;822.5064961023368;857.0358346859783;859.188067276424;860.6428332242112;861.2162931732125;862.6549380247919;838.2204549768712;845.3068483843251;846.4624963148415;847.7329641163045;850.8043150075456;618.9288231853304;622.6699849079995;628.3182746719815;628.8396458902996;629.8393909553034;14352.56942291733;14373;14384.424623015067;14394;14399.2080435576;15011.823285623523;15079.170645614488;15188.544343669597;15270.862079308794;15408.614784630361;11588.188826782129;11628.534858605646;11640.06879449642;11715.94142029293;11837;3730.7015438764834;3762.6237376262156;3785.8296376663116;3857.0550215197177;3974.066094467798;77372.61313693396;77554;81085;82549.58725206395;83048;11154.386508742096;11277.702104813205;11507.901080260732;11543.538258469567;11630.360330181922;22155.224567140074;22300;22328.21851235199;22390.776092239194;22513.099476021103;8135.511869287743;8270.503769773833;8283.58582070894;8332.208440198172;8352.540610266373;4705.435347758291;4723.315119307681;4810.254410566367;4833.95166048335;4850.417949846041;3425.811580363104;3532.752707310515;3538.398472259722;3540.7698499597445;3544.964550354515;643.2249139786546;667.9732810687518;674.9670717463216;686.2314208086974;693.2893783871472;521.8617066477386;607.4897086447405;621.8227805075531;642.6593905230235;650.4991156809231;8780.868286975701;8995.685151019814;9043.773905652411;9080.364374493722;9142.131497507726;639.3127388057857;642.2517766801624;654.780648482754;656.7637195349841;660.3198705333514;3969.861054863066;4085.7752823594988;4090.2228576570355;4178.185253875465;4259.680523960654;67583.32416675771;106690;122910;123826.38086809509;126729;109891.29189843261;110545;110812;110860.99999999838;115864.42067789607;94688;95646.52176739072;95892;97299;101549.49225253974;7784.377249820114;7842.372610191057;7877.566733829694;7958.602069896598;7973.9601301995435;52075.73962130317;53422.73288633532;53924.494907830864;54276.72861635667;55414.44585554093;69679;71140.64429677819;79106.81339780023;79127;80457;11153.107751379708;11390.145739069769;11395.715107122389;11475.196736228383;11645.301281923112;12496;12591;12661.683457913627;13213.735725285633;13228.338583071001;11509.251898626897;11898.76202475963;12102.213356131822;12155.149139560499;12363.505459781509;12168.878311216775;12191.939040305097;12616.684582885502;12758.106932514635;12849.678758031125;12010.399480026139;12063.396830158632;12569.43437545331;12706.047046471367;12772.10595258323;8969.910300897169;9244.768880778034;9333.206677432494;9557.665481708107;9656.082672146134;9575.616975320909;10197.745056373353;10203.642872499428;10209.38743675382;10225.284230103822 18:48:56 INFO - PROCESS | 15626 | __end_tp_report 18:48:56 INFO - PROCESS | 15626 | __start_cc_report 18:48:56 INFO - PROCESS | 15626 | _x_x_mozilla_cycle_collect,309 18:48:56 INFO - PROCESS | 15626 | __end_cc_report 18:48:56 INFO - PROCESS | 15626 | __startTimestamp1475286536039__endTimestamp 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | ------- Summary: start ------- 18:48:56 INFO - PROCESS | 15626 | Number of tests: 6 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#0] dojo.html Cycles:165 Average:5316.27 Median:5509.86 stddev:600.56 (10.9%) stddev-sans-first:572.40 18:48:56 INFO - PROCESS | 15626 | Values: 2926.6 2988.1 2992.4 3025.0 3033.9 5219.2 5275.3 5322.3 5323.9 5362.5 5298.2 5333.1 5348.3 5384.0 5400.7 4798.5 4903.8 4922.2 4953.6 4958.6 4979.3 4992.0 5007.8 5026.7 5035.4 4733.1 4777.8 4823.6 4919.4 4981.2 4862.5 4874.8 4891.2 4934.9 4947.9 4799.2 4841.6 4846.8 4863.1 4872.8 5140.1 5158.0 5274.9 5305.0 5401.9 5623.9 5646.0 5669.2 5672.7 5674.2 5670.3 5677.2 5760.5 5768.6 5775.6 5351.4 5362.5 5367.8 5368.7 5386.2 5865.4 5865.5 5866.4 5869.7 5929.6 5568.9 5637.6 5642.5 5642.9 5643.0 5509.9 5624.2 5675.3 5733.3 5734.8 5660.0 5661.3 5668.9 5704.0 5715.1 5651.6 5654.1 5654.8 5657.1 5663.7 4353.4 4414.7 4424.7 4428.9 4496.8 3913.9 3953.2 4004.9 4020.3 4022.9 5401.7 5491.3 5510.2 5516.9 5519.2 5599.4 5677.4 5745.4 5754.5 5763.1 5388.7 5415.9 5419.8 5440.5 5492.8 4965.7 4991.0 4993.1 4996.6 5062.4 5878.2 5898.5 5955.2 5956.8 5964.4 5659.0 5683.3 5722.1 5725.4 5789.0 5976.4 5977.1 5987.9 5992.6 6004.1 5520.6 5560.8 5605.6 5614.5 5639.8 5694.6 5733.5 5747.6 5769.3 5794.8 5622.4 5633.0 5636.5 5637.7 5638.0 5439.8 5619.1 5624.1 5627.9 5631.1 5394.6 5447.1 5458.5 5491.0 5492.4 5541.0 5557.7 5597.4 5605.7 5606.8 5486.4 5487.9 5488.3 5493.7 5560.2 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#1] ext.html Cycles:180 Average:56710.37 Median:403924.50 stddev:111726.89 (27.7%) stddev-sans-first:111960.82 18:48:56 INFO - PROCESS | 15626 | Values: 576.2 579.6 589.8 593.7 595.7 41637.8 43883.1 44074.3 46393.0 46691.3 44274.0 44640.3 44808.6 44993.6 45051.0 8743.4 8920.1 8962.1 8969.5 8974.2 8819.3 8840.8 8915.2 8934.0 8934.3 8864.8 8937.7 8956.2 8964.6 8977.4 8850.1 8902.5 8902.7 8915.1 8919.1 8726.5 8781.5 8786.6 8815.2 8833.0 42547.0 42994.1 43075.8 43084.1 43139.8 3386.3 3645.7 3744.1 3756.9 4165.9 31340.2 32168.4 32204.0 32617.6 33051.7 3633.7 3648.6 3726.6 3735.2 3849.3 322405.0 323259.0 324136.0 325215.0 325425.0 34252.3 35404.3 58308.0 58333.0 58333.7 37727.6 37742.8 37769.2 37842.8 37896.4 13740.7 13876.9 14090.5 14101.4 14118.2 10608.2 10698.1 10700.0 10708.7 10723.2 8514.3 8549.0 8606.7 8635.6 8700.7 3311.1 3336.1 3337.7 3389.4 3428.9 1022.6 1049.4 1100.4 1107.0 1122.9 31819.4 31996.0 32016.8 32285.4 32404.4 1066.8 1089.1 1168.7 1169.1 1213.3 16140.4 16663.6 16751.2 16848.4 17014.4 508712.0 509538.0 515850.0 519594.0 519857.0 56751.0 57550.7 57587.0 57763.7 57861.7 1294.5 1333.5 1349.3 1350.4 1357.0 29880.0 31330.7 31397.7 31571.0 32181.8 51505.7 51882.5 52071.0 52099.2 52136.2 398888.0 402349.0 403464.0 404385.0 405076.0 28804.6 28930.9 29010.3 29022.6 29072.3 47349.2 47507.3 48203.5 48700.8 48758.3 39877.0 40554.0 41967.8 42227.8 42803.4 40474.2 40506.0 41072.8 41959.8 42353.8 40054.2 40778.0 41393.4 41443.4 41846.8 34467.8 34558.3 37830.6 38201.0 38909.2 28399.7 28598.4 28759.0 29060.9 29124.7 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#2] jquery.html Cycles:180 Average:25587.43 Median:2592.28 stddev:64661.35 (2494.4%) stddev-sans-first:64815.05 18:48:56 INFO - PROCESS | 15626 | Values: 385.1 385.4 399.1 402.7 421.6 16962.3 17338.6 17672.2 19267.6 19357.2 12485.2 12733.2 12746.5 15432.9 19068.2 5097.1 5306.6 5307.1 5314.1 5317.5 4476.2 5706.2 5752.6 5760.8 5764.3 5478.7 5699.9 5709.8 5710.3 5714.3 5554.2 5565.6 5632.9 5633.2 5641.4 4906.6 4928.4 4978.2 5039.5 5042.3 13833.7 13990.0 14019.6 14063.2 14114.9 2320.2 2329.2 2362.4 2380.0 2804.6 9566.3 9763.2 10220.3 10418.5 10462.6 1850.2 1876.9 1882.3 1906.4 1960.9 80980.6 81559.6 81877.2 82462.0 82816.6 10930.8 11073.6 11117.6 11150.2 11182.7 15224.9 15278.3 15288.1 15301.0 15309.5 7388.4 7539.3 7600.5 7856.1 7897.3 7129.8 7150.7 7368.1 7378.2 7430.2 4510.2 4588.1 4615.5 4736.7 4820.4 1845.5 1868.2 1870.3 1870.9 1895.3 945.0 989.5 998.5 1018.2 1069.0 17364.9 18152.5 18329.6 18880.8 19160.5 965.9 978.1 989.8 1011.6 1014.3 10212.2 10237.7 10278.9 10881.3 10900.6 326290.0 327004.0 397248.0 430360.0 434585.0 93306.5 95316.0 95481.5 96585.0 97692.0 1008.8 1020.4 1054.8 1067.3 1067.5 16442.8 16852.6 17267.0 17653.0 17929.3 41535.8 41573.4 41880.0 42235.6 42374.2 59186.0 59259.0 59389.7 59492.7 59904.0 8043.5 8050.9 8115.5 8255.4 8323.1 11480.3 12804.4 12877.7 12994.8 13183.7 10708.9 10975.9 11029.6 11094.5 11546.9 10904.7 11035.5 11167.4 11322.2 11390.9 10813.6 10866.8 11192.9 11671.1 12018.7 7067.2 7718.7 8480.3 8646.8 8677.6 10562.6 11092.8 11213.9 11296.4 11538.5 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#3] mootools.html Cycles:180 Average:5858.68 Median:4452.75 stddev:3375.79 (75.8%) stddev-sans-first:3369.01 18:48:56 INFO - PROCESS | 15626 | Values: 1451.1 1500.9 1618.9 1732.6 1770.2 7851.5 8091.4 8540.9 9187.5 9207.6 8617.6 8915.2 8922.7 9057.5 9069.5 2334.5 2346.7 2367.8 2369.9 2371.9 2258.4 2304.4 2307.3 2308.5 2325.9 2317.5 2329.7 2340.7 2353.7 2365.6 2245.9 2256.5 2258.5 2259.9 2263.2 2208.7 2236.0 2236.8 2237.5 2253.8 8982.9 9043.1 9054.9 9061.7 9102.0 5018.9 5254.1 5255.8 5260.0 5263.2 3161.6 3171.1 3355.0 3362.8 3375.7 1028.6 1085.8 1092.1 1113.9 1114.9 12336.1 12426.9 12450.8 12467.0 12480.0 4384.3 4586.5 4656.0 4701.1 4702.0 10510.8 10532.4 10560.0 10581.1 10593.7 5167.4 5174.7 5175.2 5180.5 5186.5 4145.7 4260.4 4521.3 4613.5 4699.5 3872.7 3894.1 3980.2 4021.5 4114.3 1269.2 1286.7 1292.1 1298.9 1311.2 923.1 943.9 950.5 957.8 969.2 5788.0 5834.9 5894.4 5960.2 6091.9 939.2 1019.9 1046.3 1047.6 1076.7 3910.7 4127.5 4175.2 4215.1 4220.2 10925.5 11123.4 11203.9 11210.5 11237.7 11012.9 11029.5 11055.8 11106.6 11112.8 7609.6 7939.4 8363.7 8409.0 8441.7 6025.2 6283.5 6293.9 6428.9 6475.1 9991.2 10062.7 10238.8 10252.6 10380.5 10377.1 10585.1 10779.1 10811.2 10815.1 7003.8 7244.5 7635.1 7787.1 7868.3 8435.2 8746.9 8813.9 8820.2 8838.0 7762.7 7859.2 7888.5 8044.1 8104.4 7678.5 7832.6 7847.6 7872.0 7906.4 7256.6 7388.5 7402.5 7403.6 7409.8 4874.4 4969.2 4989.7 5027.4 5288.6 5006.8 5039.5 5382.7 5384.6 5488.8 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#4] prototype.html Cycles:180 Average:4470.44 Median:4932.91 stddev:1266.14 (25.7%) stddev-sans-first:1230.85 18:48:56 INFO - PROCESS | 15626 | Values: 324.2 324.5 333.5 342.2 344.5 5369.9 5407.6 5421.4 5424.3 5425.9 5302.5 5304.2 5347.8 5362.9 5412.3 3927.4 4165.3 4209.2 4269.5 4273.5 4179.0 4179.7 4186.4 4202.2 4242.3 4125.8 4166.6 4187.3 4192.6 4194.9 4005.7 4118.0 4139.9 4154.5 4155.5 3650.7 3654.1 3658.0 3668.6 3683.0 5269.3 5280.7 5291.1 5292.8 5307.3 4581.0 4755.9 4761.5 4777.6 4790.7 5538.9 5547.7 5549.0 5555.9 5572.9 4022.5 4024.8 4025.2 4028.9 4046.3 5647.4 5774.9 5801.2 5806.7 5855.8 4111.3 4125.5 4130.9 4155.8 4157.3 4200.6 4217.3 4217.6 4220.9 4229.7 4667.8 4783.3 4791.7 4796.9 4819.5 5551.3 5569.4 5575.1 5587.0 5630.3 1429.7 1441.5 1447.8 1458.6 1462.0 865.1 916.0 921.5 939.5 947.9 4827.1 4829.9 4839.8 4855.2 4879.6 5009.9 5052.4 5054.9 5096.8 5135.3 4675.8 4864.7 4874.3 4881.5 4888.7 2719.8 2721.6 2731.0 2733.7 2736.4 5228.8 5259.9 5291.9 5302.4 5366.3 4902.0 5092.7 5123.8 5201.3 5224.5 5255.4 5303.5 5305.7 5340.3 5342.7 5086.2 5130.9 5134.0 5147.5 5168.6 4662.6 4917.9 4954.5 4978.5 5031.9 5222.4 5234.2 5272.5 5291.5 5305.4 3739.8 3744.9 3758.3 3763.3 3789.6 4963.5 5019.6 5025.6 5031.4 5124.2 4902.5 4905.3 4928.4 4931.8 4938.9 4901.8 4929.5 4939.0 4962.8 4974.5 4607.8 4920.6 4934.0 4935.3 4950.3 4999.9 5375.8 5554.6 5639.5 5684.5 5535.2 5575.2 5623.3 5627.6 5640.6 18:48:56 INFO - PROCESS | 15626 | 18:48:56 INFO - PROCESS | 15626 | [#5] yui.html Cycles:180 Average:21152.46 Median:4766.78 stddev:31826.36 (667.7%) stddev-sans-first:31878.48 18:48:56 INFO - PROCESS | 15626 | Values: 670.2 747.6 761.3 764.3 768.0 14583.6 15641.4 15760.1 15776.2 15892.8 13569.6 13988.2 14221.6 14276.2 14308.0 794.1 810.0 812.1 812.2 812.2 778.6 808.8 817.0 817.1 822.5 857.0 859.2 860.6 861.2 862.7 838.2 845.3 846.5 847.7 850.8 618.9 622.7 628.3 628.8 629.8 14352.6 14373.0 14384.4 14394.0 14399.2 15011.8 15079.2 15188.5 15270.9 15408.6 11588.2 11628.5 11640.1 11715.9 11837.0 3730.7 3762.6 3785.8 3857.1 3974.1 77372.6 77554.0 81085.0 82549.6 83048.0 11154.4 11277.7 11507.9 11543.5 11630.4 22155.2 22300.0 22328.2 22390.8 22513.1 8135.5 8270.5 8283.6 8332.2 8352.5 4705.4 4723.3 4810.3 4834.0 4850.4 3425.8 3532.8 3538.4 3540.8 3545.0 643.2 668.0 675.0 686.2 693.3 521.9 607.5 621.8 642.7 650.5 8780.9 8995.7 9043.8 9080.4 9142.1 639.3 642.3 654.8 656.8 660.3 3969.9 4085.8 4090.2 4178.2 4259.7 67583.3 106690.0 122910.0 123826.4 126729.0 109891.3 110545.0 110812.0 110861.0 115864.4 94688.0 95646.5 95892.0 97299.0 101549.5 7784.4 7842.4 7877.6 7958.6 7974.0 52075.7 53422.7 53924.5 54276.7 55414.4 69679.0 71140.6 79106.8 79127.0 80457.0 11153.1 11390.1 11395.7 11475.2 11645.3 12496.0 12591.0 12661.7 13213.7 13228.3 11509.3 11898.8 12102.2 12155.1 12363.5 12168.9 12191.9 12616.7 12758.1 12849.7 12010.4 12063.4 12569.4 12706.0 12772.1 8969.9 9244.8 9333.2 9557.7 9656.1 9575.6 10197.7 10203.6 10209.4 10225.3 18:48:56 INFO - PROCESS | 15626 | -------- Summary: end -------- 18:48:56 INFO - PROCESS | 15626 | 18:48:57 INFO - TEST-INFO | 15626: exit 0 18:48:57 INFO - TEST-OK | dromaeo_css | took 1113573ms 18:48:57 INFO - TEST-START | kraken 18:48:57 INFO - operating with platform_type : linux_ 18:48:57 INFO - Initialising browser for kraken test... 18:48:57 INFO - TEST-INFO | started process 15985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvTJMUW/profile http://localhost:57344/getInfo.html) 18:49:01 INFO - PROCESS | 15985 | __metrics Screen width/height:1600/1200 18:49:01 INFO - PROCESS | 15985 | colorDepth:24 18:49:01 INFO - PROCESS | 15985 | Browser inner width/height: 1024/697 18:49:01 INFO - PROCESS | 15985 | __metrics 18:49:02 ERROR - PROCESS | 15985 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 18:49:03 INFO - TEST-INFO | 15985: exit 0 18:49:03 INFO - Browser initialized. 18:49:03 INFO - Running cycle 1/1 for kraken test... 18:49:03 INFO - TEST-INFO | started process 16111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvTJMUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:15 INFO - PROCESS | 16111 | RSS: Main: 186134528 18:49:15 INFO - PROCESS | 16111 | 18:49:18 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57344/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:19 INFO - PROCESS | 16111 | RSS: Main: 200134656 18:49:19 INFO - PROCESS | 16111 | 18:49:21 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57344/tests/kraken/driver.html?testName=audio-dft) 18:49:22 INFO - PROCESS | 16111 | RSS: Main: 197853184 18:49:22 INFO - PROCESS | 16111 | 18:49:25 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57344/tests/kraken/driver.html?testName=audio-fft) 18:49:25 INFO - PROCESS | 16111 | RSS: Main: 193650688 18:49:25 INFO - PROCESS | 16111 | 18:49:28 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57344/tests/kraken/driver.html?testName=audio-oscillator) 18:49:28 INFO - PROCESS | 16111 | RSS: Main: 194568192 18:49:28 INFO - PROCESS | 16111 | 18:49:30 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:31 INFO - PROCESS | 16111 | RSS: Main: 194818048 18:49:31 INFO - PROCESS | 16111 | 18:49:34 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57344/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:35 INFO - PROCESS | 16111 | RSS: Main: 194961408 18:49:35 INFO - PROCESS | 16111 | 18:49:38 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57344/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:39 INFO - PROCESS | 16111 | RSS: Main: 195100672 18:49:39 INFO - PROCESS | 16111 | 18:49:42 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57344/tests/kraken/driver.html?testName=json-parse-financial) 18:49:42 INFO - PROCESS | 16111 | RSS: Main: 195072000 18:49:42 INFO - PROCESS | 16111 | 18:49:44 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:44 INFO - PROCESS | 16111 | RSS: Main: 194854912 18:49:44 INFO - PROCESS | 16111 | 18:49:46 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:47 INFO - PROCESS | 16111 | RSS: Main: 194945024 18:49:47 INFO - PROCESS | 16111 | 18:49:49 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:49:50 INFO - PROCESS | 16111 | RSS: Main: 194740224 18:49:50 INFO - PROCESS | 16111 | 18:49:52 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:49:53 INFO - PROCESS | 16111 | RSS: Main: 194838528 18:49:53 INFO - PROCESS | 16111 | 18:49:56 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:49:56 INFO - PROCESS | 16111 | RSS: Main: 195506176 18:49:56 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | Cycle 1(1): loaded http://localhost:57344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57344/tests/kraken/driver.html?testName=ai-astar) 18:49:58 INFO - PROCESS | 16111 | RSS: Main: 196710400 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | __start_tp_report 18:49:58 INFO - PROCESS | 16111 | _x_x_mozilla_page_load 18:49:58 INFO - PROCESS | 16111 | _x_x_mozilla_page_load_details 18:49:58 INFO - PROCESS | 16111 | |i|pagename|runs| 18:49:58 INFO - PROCESS | 16111 | |0;ai-astar;109;115;115;114;111;114;115;115;119;119 18:49:58 INFO - PROCESS | 16111 | |1;audio-beat-detection;155;125;128;168;125;126;126;129;161;124 18:49:58 INFO - PROCESS | 16111 | |2;audio-dft;162;163;165;173;162;164;162;163;164;160 18:49:58 INFO - PROCESS | 16111 | |3;audio-fft;75;77;79;105;78;75;77;78;99;75 18:49:58 INFO - PROCESS | 16111 | |4;audio-oscillator;83;81;114;82;82;82;100;82;82;115 18:49:58 INFO - PROCESS | 16111 | |5;imaging-gaussian-blur;118;118;117;117;118;119;117;119;119;119 18:49:58 INFO - PROCESS | 16111 | |6;imaging-darkroom;147;147;146;146;148;147;146;146;148;147 18:49:58 INFO - PROCESS | 16111 | |7;imaging-desaturate;97;98;97;96;101;96;96;96;96;95 18:49:58 INFO - PROCESS | 16111 | |8;json-parse-financial;54;55;54;53;55;54;57;58;54;54 18:49:58 INFO - PROCESS | 16111 | |9;json-stringify-tinderbox;60;62;60;60;61;62;62;62;62;62 18:49:58 INFO - PROCESS | 16111 | |10;stanford-crypto-aes;81;81;87;81;80;86;89;80;86;81 18:49:58 INFO - PROCESS | 16111 | |11;stanford-crypto-ccm;135;129;144;132;141;133;141;131;182;139 18:49:58 INFO - PROCESS | 16111 | |12;stanford-crypto-pbkdf2;176;171;171;174;171;169;170;171;168;181 18:49:58 INFO - PROCESS | 16111 | |13;stanford-crypto-sha256-iterative;68;69;67;67;67;66;71;66;69;70 18:49:58 INFO - PROCESS | 16111 | __end_tp_report 18:49:58 INFO - PROCESS | 16111 | __start_cc_report 18:49:58 INFO - PROCESS | 16111 | _x_x_mozilla_cycle_collect,803 18:49:58 INFO - PROCESS | 16111 | __end_cc_report 18:49:58 INFO - PROCESS | 16111 | __startTimestamp1475286598954__endTimestamp 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | ------- Summary: start ------- 18:49:58 INFO - PROCESS | 16111 | Number of tests: 14 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:2.49 18:49:58 INFO - PROCESS | 16111 | Values: 109.0 115.0 115.0 114.0 111.0 114.0 115.0 115.0 119.0 119.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:128.50 stddev:17.33 (13.5%) stddev-sans-first:17.07 18:49:58 INFO - PROCESS | 16111 | Values: 155.0 125.0 128.0 168.0 125.0 126.0 126.0 129.0 161.0 124.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.52 (2.2%) stddev-sans-first:3.67 18:49:58 INFO - PROCESS | 16111 | Values: 162.0 163.0 165.0 173.0 162.0 164.0 162.0 163.0 164.0 160.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.50 stddev:10.83 (14.0%) stddev-sans-first:11.20 18:49:58 INFO - PROCESS | 16111 | Values: 75.0 77.0 79.0 105.0 78.0 75.0 77.0 78.0 99.0 75.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.94 (17.0%) stddev-sans-first:14.54 18:49:58 INFO - PROCESS | 16111 | Values: 83.0 81.0 114.0 82.0 82.0 82.0 100.0 82.0 82.0 115.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.93 18:49:58 INFO - PROCESS | 16111 | Values: 118.0 118.0 117.0 117.0 118.0 119.0 117.0 119.0 119.0 119.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:49:58 INFO - PROCESS | 16111 | Values: 147.0 147.0 146.0 146.0 148.0 147.0 146.0 146.0 148.0 147.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.69 (1.8%) stddev-sans-first:1.79 18:49:58 INFO - PROCESS | 16111 | Values: 97.0 98.0 97.0 96.0 101.0 96.0 96.0 96.0 96.0 95.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.62 18:49:58 INFO - PROCESS | 16111 | Values: 54.0 55.0 54.0 53.0 55.0 54.0 57.0 58.0 54.0 54.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 18:49:58 INFO - PROCESS | 16111 | Values: 60.0 62.0 60.0 60.0 61.0 62.0 62.0 62.0 62.0 62.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:3.39 (4.1%) stddev-sans-first:3.50 18:49:58 INFO - PROCESS | 16111 | Values: 81.0 81.0 87.0 81.0 80.0 86.0 89.0 80.0 86.0 81.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.00 stddev:15.34 (11.0%) stddev-sans-first:16.13 18:49:58 INFO - PROCESS | 16111 | Values: 135.0 129.0 144.0 132.0 141.0 133.0 141.0 131.0 182.0 139.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:171.00 stddev:3.85 (2.3%) stddev-sans-first:3.83 18:49:58 INFO - PROCESS | 16111 | Values: 176.0 171.0 171.0 174.0 171.0 169.0 170.0 171.0 168.0 181.0 18:49:58 INFO - PROCESS | 16111 | 18:49:58 INFO - PROCESS | 16111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 18:49:58 INFO - PROCESS | 16111 | Values: 68.0 69.0 67.0 67.0 67.0 66.0 71.0 66.0 69.0 70.0 18:49:58 INFO - PROCESS | 16111 | -------- Summary: end -------- 18:49:58 INFO - PROCESS | 16111 | 18:50:00 INFO - TEST-INFO | 16111: exit 0 18:50:00 INFO - TEST-OK | kraken | took 63023ms 18:50:00 INFO - SUITE-END | took 1176s 18:50:00 INFO - Completed test suite (00:19:37) 18:50:00 INFO - javascript benchmark 18:50:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7024.941910224254, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2926.61953945987, 2988.103568929321, 2992.3566433216856, 3025.0, 3033.9089827305174, 5219.217117432382, 5275.261463395128, 5322.2814919985885, 5323.866903327414, 5362.490563396481, 5298.178782288752, 5333.146696528556, 5348.304720386344, 5384.030874442598, 5400.729963501819, 4798.520147985199, 4903.754812259391, 4922.163232250508, 4953.578945789613, 4958.603311735071, 4979.278004689318, 4992.0, 5007.799688012475, 5026.748662566875, 5035.420926593452, 4733.100710864959, 4777.8327758528285, 4823.5658790709, 4919.434265059528, 4981.203007518798, 4862.513748625144, 4874.805007799684, 4891.1685013547785, 4934.851954441372, 4947.90104197914, 4799.18413869643, 4841.588464980481, 4846.7818948147415, 4863.10032643962, 4872.805087796484, 5140.074786538422, 5158.0199762045095, 5274.868128296824, 5305.0450918834595, 5401.945980540184, 5623.8594035149035, 5646.040173170571, 5669.206311116447, 5672.659640421547, 5674.205611214434, 5670.3479099903625, 5677.233573467571, 5760.510356619692, 5768.596198266123, 5775.624584402, 5351.357837059578, 5362.490563396432, 5367.785288588452, 5368.711509237833, 5386.165144402624, 5865.4134586541, 5865.472107510259, 5866.354700982888, 5869.706514674249, 5929.6145750526075, 5568.916466253009, 5637.577181711388, 5642.492175704124, 5642.943570564242, 5643.040683083804, 5509.862253443696, 5624.184493248456, 5675.262215911905, 5733.254676891977, 5734.770609175586, 5660.0, 5661.34894487131, 5668.943310566841, 5704.001799685038, 5715.114157305624, 5651.576131790132, 5654.123610840326, 5654.802081927113, 5657.066584013592, 5663.745131469093, 4353.412289340962, 4414.735115893057, 4424.73451592899, 4428.933565996513, 4496.820127194941, 3913.8630147944687, 3953.2093581283284, 4004.9199016020098, 4020.3366444536323, 4022.8591999279884, 5401.702906340189, 5491.28613280271, 5510.201020851954, 5516.889662206733, 5519.172124181405, 5599.384067752544, 5677.37548869624, 5745.368009518949, 5754.482096611325, 5763.106718458645, 5388.676679399248, 5415.891682166334, 5419.783208671609, 5440.483154100354, 5492.835214943558, 4965.677230980047, 4991.0, 4993.101241776515, 4996.625253106032, 5062.443131255559, 5878.2358293421585, 5898.469137777621, 5955.196048533479, 5956.791512297049, 5964.433378829004, 5658.971705141613, 5683.318001839806, 5722.141678748221, 5725.370209276893, 5789.0, 5976.372480889444, 5977.103434484862, 5987.910181347371, 5992.610480318765, 6004.1294012368835, 5520.558355331644, 5560.833175004756, 5605.5515558756015, 5614.522765564972, 5639.830805075854, 5694.629849059798, 5733.483986441241, 5747.568932330176, 5769.278840144982, 5794.768209271582, 5622.409646987007, 5633.0, 5636.492715655447, 5637.746301416528, 5638.041532939328, 5439.782408703608, 5619.100943848965, 5624.072028115315, 5627.915581266202, 5631.070873305859, 5394.622376433612, 5447.128459446628, 5458.4541545845095, 5491.039068162976, 5492.395836457907, 5540.972295138498, 5557.694326811902, 5597.412271711574, 5605.719714014202, 5606.775728970959, 5486.396496385315, 5487.934766993167, 5488.313960754906, 5493.670379777226, 5560.249366335493], "value": 5275.087812395881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2451188942485, 579.6000759475959, 589.7935722497126, 593.7476572456707, 595.6515438468496, 41637.79181104094, 43883.12233755323, 44074.33888491671, 46393.0, 46691.299630505484, 44274.0, 44640.3303950441, 44808.55191448093, 44993.550064499344, 45051.0, 8743.431676940978, 8920.107989201093, 8962.148595883413, 8969.461832290051, 8974.23718983884, 8819.294456443502, 8840.778980525507, 8915.1976322131, 8934.0, 8934.329925255599, 8864.778380540505, 8937.687180948667, 8956.19394254517, 8964.551772411385, 8977.416467929595, 8850.114988501162, 8902.510361930124, 8902.73291801247, 8915.108489151098, 8919.108089191093, 8726.52004139772, 8781.473111613324, 8786.64853405863, 8815.162559556831, 8833.028366879638, 42547.0, 42994.14011719748, 43075.784621076695, 43084.138317233796, 43139.78430107861, 3386.255023894739, 3645.6536629020466, 3744.0826997385543, 3756.906077348061, 4165.895852603679, 31340.21649458759, 32168.356632867446, 32204.0, 32617.596624455633, 33051.6694833051, 3633.7274704397278, 3648.5986541480415, 3726.5528136623507, 3735.178260782651, 3849.30712471755, 322405.0, 323259.0, 324136.0, 325215.0, 325425.0, 34252.314953700785, 35404.29191416157, 58308.0, 58333.0, 58333.708331458074, 37727.62272377241, 37742.8112859434, 37769.24461510754, 37842.81078594589, 37896.431553526716, 13740.65648358799, 13876.930615346859, 14090.506832260822, 14101.365438555289, 14118.223497707724, 10608.204384671026, 10698.144148468104, 10700.0, 10708.732281692864, 10723.19576031785, 8514.318854491627, 8548.957255213683, 8606.698765543177, 8635.611397487128, 8700.738977830675, 3311.089450401159, 3336.099253201622, 3337.682920122633, 3389.3561622613015, 3428.8971330860113, 1022.6420752736632, 1049.391908662199, 1100.3702691284911, 1106.9723256918642, 1122.859642544682, 31819.363612727615, 31996.0, 32016.839915800272, 32285.35429291448, 32404.351912961607, 1066.7919755647574, 1089.1232557791054, 1168.7311918258847, 1169.0764296206073, 1213.2962881528692, 16140.354385824436, 16663.583410414838, 16751.246193921303, 16848.410305639245, 17014.404495842587, 508712.0, 509538.0, 515850.0, 519594.0, 519857.0, 56751.0, 57550.7122464385, 57587.0, 57763.71118144466, 57861.710691447115, 1294.5339677716015, 1333.4732780551822, 1349.2646507653353, 1350.3855745635713, 1357.0, 29880.0, 31330.68669313278, 31397.686023139475, 31571.0, 32181.839090804395, 51505.742471287405, 51882.481175187764, 52071.0, 52099.21851172311, 52136.21795672992, 398888.0, 402349.0, 403464.0, 404385.0, 405076.0, 28804.567931481462, 28930.85534572398, 29010.27474313159, 29022.564661529672, 29072.27319317034, 47349.196358211564, 47507.28739068986, 48203.517964819905, 48700.75649621729, 48758.268625969926, 39877.0, 40554.0, 41967.790161049, 42227.788861055495, 42803.35794963016, 40474.1905161901, 40506.0, 41072.79463602663, 41959.790201048796, 42353.78823105988, 40054.1989160221, 40778.0, 41393.37909931293, 41443.37834932539, 41846.790766045975, 34467.827660861534, 34558.308833823685, 37830.62169378271, 38201.0, 38909.221815564095, 28399.71600283971, 28598.428031438838, 28759.0, 29060.854695726386, 29124.708752913048], "value": 18670.50382754863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1161584164344, 385.3641491538962, 399.09405649176364, 402.73620778390153, 421.572104314121, 16962.3215071397, 17338.56653583661, 17672.20475078621, 19267.614647707036, 19357.225710971543, 12485.188462749938, 12733.236005839655, 12746.490140394373, 15432.922835385807, 19068.237270509162, 5097.108006098927, 5306.628536002481, 5307.071262529062, 5314.123169676998, 5317.468253174671, 4476.2390393632995, 5706.229658996044, 5752.597318187729, 5760.827175184731, 5764.308283006045, 5478.671279723229, 5699.886002279952, 5709.800156994506, 5710.257666503348, 5714.342850572196, 5554.222408862763, 5565.6104072714925, 5632.915506267409, 5633.211350410946, 5641.351244606861, 4906.558409743105, 4928.408590969071, 4978.203487442028, 5039.546440820307, 5042.268871013719, 13833.654158646013, 13990.020698551105, 14019.64950876226, 14063.226522541256, 14114.85885141156, 2320.1647406933657, 2329.208069256444, 2362.444825466014, 2379.988100059506, 2804.5652923796843, 9566.282528810367, 9763.218942484584, 10220.335678180894, 10418.531166097468, 10462.581496740122, 1850.2321536562445, 1876.859235557325, 1882.265916292647, 1906.3804263614243, 1960.892150931698, 80980.59509702414, 81559.5922020386, 81877.18122818755, 82462.0, 82816.58591707062, 10930.836037459445, 11073.5570577176, 11117.555297787998, 11150.21948463616, 11182.720431989266, 15224.923875380553, 15278.31247593861, 15288.082715037133, 15301.0, 15309.540713778604, 7388.445866559922, 7539.32146106853, 7600.543967361976, 7856.057273127261, 7897.289243968071, 7129.750458734024, 7150.713971441084, 7368.115826100902, 7378.1515125761225, 7430.182679905206, 4510.233260345683, 4588.128255631486, 4615.538446155425, 4736.739479328601, 4820.4456487504385, 1845.508563439346, 1868.2060124447055, 1870.326682394337, 1870.8596855235912, 1895.2608482691762, 944.9716508504756, 989.4656885281867, 998.4558415663481, 1018.180364806338, 1068.983965240522, 17364.91317543404, 18152.45542633723, 18329.633407331778, 18880.811191887904, 19160.52098697516, 965.8937516873139, 978.105033893979, 989.8020395920701, 1011.595361855249, 1014.3406785589426, 10212.234082443847, 10237.692869213935, 10278.897211027943, 10881.292715973437, 10900.582924219801, 326290.0, 327004.0, 397248.0, 430360.0, 434585.0, 93306.53346733224, 95315.99999999862, 95481.5225923866, 96585.0, 97692.0, 1008.8335424654997, 1020.4183615339185, 1054.8154073037188, 1067.3435836960368, 1067.5462928255615, 16442.83557164413, 16852.57868553296, 17267.0, 17653.0, 17929.282828687228, 41535.7923210382, 41573.37639935343, 41880.0, 42235.577644223165, 42374.152516950104, 59186.0, 59259.0, 59389.70305148447, 59492.70253648704, 59904.0, 8043.477173983672, 8050.919490805251, 8115.472494287852, 8255.42212045151, 8323.12607176262, 11480.311181329147, 12804.359782011048, 12877.742445150858, 12994.80507792365, 13183.67040823987, 10708.89291107079, 10975.945120274348, 11029.61396351124, 11094.500747466545, 11546.884531154918, 10904.727381815517, 11035.503402347074, 11167.38579378142, 11322.207445478738, 11390.886091138982, 10813.62152324665, 10866.836997444887, 11192.888071119185, 11671.12466564994, 12018.699532511757, 7067.151941767021, 7718.729844455417, 8480.321574274167, 8646.78383040429, 8677.6095075723, 10562.577496900038, 11092.778144436905, 11213.943930280622, 11296.378699171624, 11538.480768365276], "value": 8766.81066798107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.0858159359602, 1500.8574185452383, 1618.8866779325444, 1732.5841797968483, 1770.1680210301154, 7851.528908265508, 8091.3526917846575, 8540.914590854098, 9187.540622968858, 9207.585658645361, 8617.56912154393, 8915.153060459246, 8922.732318030454, 9057.50183739894, 9069.455832650046, 2334.509752951882, 2346.7301260355107, 2367.810575153992, 2369.9407514812183, 2371.9407014824683, 2258.390234636647, 2304.412374844412, 2307.3193407944614, 2308.5382923415386, 2325.8953347099336, 2317.455397981473, 2329.7204335479682, 2340.6840076589615, 2353.6587194856734, 2365.6215005599106, 2245.865248085112, 2256.5035692147703, 2258.469259723972, 2259.9322020339414, 2263.2305016294376, 2208.6907832903407, 2235.9888200558894, 2236.787505187021, 2237.463008877874, 2253.8196944244423, 8982.86525702115, 9043.050479699603, 9054.909450905472, 9061.682841100595, 9102.04428535001, 5018.899622007576, 5254.133068043769, 5255.842324730226, 5260.0, 5263.210518422229, 3161.604799400075, 3171.1279398165457, 3354.983225083859, 3362.8150451725146, 3375.6961873431264, 1028.5731272884009, 1085.79369919715, 1092.071739021833, 1113.8774734779167, 1114.921955463118, 12336.074794390457, 12426.937865310616, 12450.81323780144, 12467.0, 12480.0, 4384.254676704968, 4586.472555656075, 4655.953440465552, 4701.106789710013, 4702.0, 10510.842337364946, 10532.420716860646, 10560.0, 10581.100606448537, 10593.682189534326, 5167.431582525919, 5174.741262936838, 5175.197844334134, 5180.507851754077, 5186.481351864859, 4145.709800314009, 4260.403543503912, 4521.253993091103, 4613.469451013109, 4699.530046995342, 3872.6901847852105, 3894.123822139996, 3980.1641655252142, 4021.4973128358956, 4114.341705327193, 1269.206745783885, 1286.7297867447753, 1292.095533126815, 1298.8506321773118, 1311.1805121798875, 923.1276443760715, 943.9103285187896, 950.5057370167474, 957.8036502516967, 969.2149359019216, 5788.0, 5834.854128646818, 5894.440028197314, 5960.195373624592, 6091.908621370594, 939.2392162348519, 1019.938803671782, 1046.3094357723867, 1047.5966752800227, 1076.7254350140663, 3910.687145028448, 4127.525334586501, 4175.227582897173, 4215.072684009513, 4220.177065472203, 10925.508352124174, 11123.443827808576, 11203.94398028021, 11210.495527701272, 11237.662870113909, 11012.898710128922, 11029.503672334764, 11055.834162487568, 11106.61126860556, 11112.833307500232, 7609.619519024137, 7939.364850811921, 8363.665453381918, 8409.0, 8441.704540341181, 6025.246844144482, 6283.465905398092, 6293.937060629335, 6428.903566446414, 6475.061116138039, 9991.150752186146, 10062.748431289276, 10238.846417303896, 10252.58989640406, 10380.48097595102, 10377.11794497446, 10585.100266477435, 10779.083777878654, 10811.243212975016, 10815.134789216687, 7003.7548685795755, 7244.529105608119, 7635.083789945242, 7787.10448298453, 7868.25251601097, 8435.24082832548, 8746.868796968178, 8813.867791983253, 8820.2061814437, 8838.02781694026, 7762.68949242024, 7859.214078592095, 7888.48724832884, 8044.115147333906, 8104.392170587347, 7678.5392876427595, 7832.647530861011, 7847.646855891613, 7872.0, 7906.407019473448, 7256.600886951268, 7388.519746216479, 7402.518836275625, 7403.5928023959195, 7409.777706668809, 4874.439439464365, 4969.155243608668, 4989.700617962933, 5027.371578552681, 5288.550473209666, 5006.824761133343, 5039.521245481674, 5382.7308634567335, 5384.6499977501335, 5488.780448782004], "value": 4669.465206189238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.2331885091758, 324.4500571531254, 333.4714477553079, 342.23851929456947, 344.4729563767435, 5369.9463005369935, 5407.594430417715, 5421.430749771272, 5424.349078110622, 5425.864353391167, 5302.469753024696, 5304.1965731651235, 5347.786088556453, 5362.892742145154, 5412.269343638608, 3927.430522574225, 4165.291900376943, 4209.200251952119, 4269.530351661315, 4273.508546517143, 4178.958210417903, 4179.728317659357, 4186.413902053715, 4202.180574787918, 4242.321228603424, 4125.773082480462, 4166.625003749662, 4187.28816101262, 4192.5807419258135, 4194.867385805831, 4005.6995725320426, 4118.032262418329, 4139.855105071339, 4154.50145982484, 4155.4805649293685, 3650.7444478886487, 3654.086478380405, 3657.963420365789, 3668.559772827251, 3682.963170368289, 5269.262303277545, 5280.683159010472, 5291.126964050927, 5292.814751483718, 5307.336582927134, 4580.9541904580865, 4755.9286610700865, 4761.500042495522, 4777.593904518086, 4790.6886052406835, 5538.944610553883, 5547.694876781816, 5548.9722551386985, 5555.861103472405, 5572.888542229173, 4022.5374081980654, 4024.839006439739, 4025.1547175093265, 4028.879133625996, 4046.271671099201, 5647.407022262644, 5774.884502309972, 5801.187833703285, 5806.709664516799, 5855.824325270206, 4111.342185250345, 4125.546189919107, 4130.91738165241, 4155.812988415529, 4157.314043182841, 4200.60094291048, 4217.304144816071, 4217.557156498585, 4220.894477638022, 4229.746215227096, 4667.806606695922, 4783.330333753277, 4791.664583479123, 4796.856094317176, 4819.469858315582, 5551.333839939233, 5569.415211402826, 5575.135853942565, 5586.972065139729, 5630.324361076697, 1429.7212043651596, 1441.509886638527, 1447.8117844680123, 1458.562431270636, 1461.9561413157621, 865.1219012702112, 915.9633614655472, 921.5254144115786, 939.4879790514186, 947.9336446448821, 4827.069172331096, 4829.9275510867365, 4839.765859705823, 4855.174620314555, 4879.560839524389, 5009.949900500948, 5052.418971818214, 5054.927479733292, 5096.770645320969, 5135.281060651437, 4675.812967481331, 4864.708117512961, 4874.341963834908, 4881.51184881509, 4888.7311197884455, 2719.8440662718267, 2721.5917612357907, 2731.0, 2733.658292713411, 2736.4390299988454, 5228.764705588258, 5259.921101183485, 5291.867703307448, 5302.39022512416, 5366.290023538167, 4901.975490122527, 5092.719900405439, 5123.795048198031, 5201.349831271091, 5224.544464101866, 5255.369355677343, 5303.549198318186, 5305.681659100389, 5340.332458442695, 5342.679439233659, 5086.21163719624, 5130.923036154386, 5134.0, 5147.4557632710785, 5168.58651307887, 4662.603678687349, 4917.877053073702, 4954.529319714621, 4978.47725988766, 5031.874203144951, 5222.381061870832, 5234.205201229079, 5272.499112584298, 5291.491924801413, 5305.400353826674, 3739.8317075732202, 3744.876537038823, 3758.3275442427857, 3763.284975854579, 3789.583145854009, 4963.4540200577185, 5019.598432125495, 5025.597952163891, 5031.4213865405945, 5124.15530409045, 4902.509749025212, 4905.337779399735, 4928.433230178575, 4931.827386041471, 4938.901221975612, 4901.754912254301, 4929.457759646508, 4939.0243902439315, 4962.801487940442, 4974.502549744997, 4607.815687372467, 4920.597629675525, 4934.0, 4935.2973224237585, 4950.282209079592, 4999.900002000012, 5375.784968601212, 5554.583406244467, 5639.464250896158, 5684.459976302244, 5535.232383808096, 5575.1915972184615, 5623.325200975909, 5627.606067575231, 5640.605157638925], "value": 4072.230629729988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2191946382463, 747.6037700018989, 761.299604363985, 764.2624867003341, 768.043785487068, 14583.562493125197, 15641.374345026214, 15760.133192674428, 15776.211189440524, 15892.761608575865, 13569.592912212625, 13988.230647314394, 14221.573352799407, 14276.214808185545, 14308.0, 794.1383598795314, 809.9676012959475, 812.1229072601606, 812.175641723648, 812.2364976921705, 778.5990215039259, 808.7735434078438, 816.967321307147, 817.1256755271861, 822.5064961023368, 857.0358346859783, 859.188067276424, 860.6428332242112, 861.2162931732125, 862.6549380247919, 838.2204549768712, 845.3068483843251, 846.4624963148415, 847.7329641163045, 850.8043150075456, 618.9288231853304, 622.6699849079995, 628.3182746719815, 628.8396458902996, 629.8393909553034, 14352.56942291733, 14373.0, 14384.424623015067, 14394.0, 14399.2080435576, 15011.823285623523, 15079.170645614488, 15188.544343669597, 15270.862079308794, 15408.614784630361, 11588.188826782129, 11628.534858605646, 11640.06879449642, 11715.94142029293, 11837.0, 3730.7015438764834, 3762.6237376262156, 3785.8296376663116, 3857.0550215197177, 3974.066094467798, 77372.61313693396, 77554.0, 81085.0, 82549.58725206395, 83048.0, 11154.386508742096, 11277.702104813205, 11507.901080260732, 11543.538258469567, 11630.360330181922, 22155.224567140074, 22300.0, 22328.21851235199, 22390.776092239194, 22513.099476021103, 8135.511869287743, 8270.503769773833, 8283.58582070894, 8332.208440198172, 8352.540610266373, 4705.435347758291, 4723.315119307681, 4810.254410566367, 4833.95166048335, 4850.417949846041, 3425.811580363104, 3532.752707310515, 3538.398472259722, 3540.7698499597445, 3544.964550354515, 643.2249139786546, 667.9732810687518, 674.9670717463216, 686.2314208086974, 693.2893783871472, 521.8617066477386, 607.4897086447405, 621.8227805075531, 642.6593905230235, 650.4991156809231, 8780.868286975701, 8995.685151019814, 9043.773905652411, 9080.364374493722, 9142.131497507726, 639.3127388057857, 642.2517766801624, 654.780648482754, 656.7637195349841, 660.3198705333514, 3969.861054863066, 4085.7752823594988, 4090.2228576570355, 4178.185253875465, 4259.680523960654, 67583.32416675771, 106690.0, 122910.0, 123826.38086809509, 126729.0, 109891.29189843261, 110545.0, 110812.0, 110860.99999999838, 115864.42067789607, 94688.0, 95646.52176739072, 95892.0, 97299.0, 101549.49225253974, 7784.377249820114, 7842.372610191057, 7877.566733829694, 7958.602069896598, 7973.9601301995435, 52075.73962130317, 53422.73288633532, 53924.494907830864, 54276.72861635667, 55414.44585554093, 69679.0, 71140.64429677819, 79106.81339780023, 79127.0, 80457.0, 11153.107751379708, 11390.145739069769, 11395.715107122389, 11475.196736228383, 11645.301281923112, 12496.0, 12591.0, 12661.683457913627, 13213.735725285633, 13228.338583071001, 11509.251898626897, 11898.76202475963, 12102.213356131822, 12155.149139560499, 12363.505459781509, 12168.878311216775, 12191.939040305097, 12616.684582885502, 12758.106932514635, 12849.678758031125, 12010.399480026139, 12063.396830158632, 12569.43437545331, 12706.047046471367, 12772.10595258323, 8969.910300897169, 9244.768880778034, 9333.206677432494, 9557.665481708107, 9656.082672146134, 9575.616975320909, 10197.745056373353, 10203.642872499428, 10209.38743675382, 10225.284230103822], "value": 7319.583699304545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 115.0, 114.0, 111.0, 114.0, 115.0, 115.0, 119.0, 119.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 128.0, 168.0, 125.0, 126.0, 126.0, 129.0, 161.0, 124.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 173.0, 162.0, 164.0, 162.0, 163.0, 164.0, 160.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 79.0, 105.0, 78.0, 75.0, 77.0, 78.0, 99.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 114.0, 82.0, 82.0, 82.0, 100.0, 82.0, 82.0, 115.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 119.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 96.0, 101.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 55.0, 54.0, 57.0, 58.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 60.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 87.0, 81.0, 80.0, 86.0, 89.0, 80.0, 86.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 144.0, 132.0, 141.0, 133.0, 141.0, 131.0, 182.0, 139.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 171.0, 174.0, 171.0, 169.0, 170.0, 171.0, 168.0, 181.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 67.0, 66.0, 71.0, 66.0, 69.0, 70.0], "value": 68.0, "unit": "score"}]}]} 18:50:00 INFO - Return code: 0 18:50:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:00 ERROR - # TBPL SUCCESS # 18:50:00 INFO - Running post-action listener: _resource_record_post_action 18:50:00 INFO - [mozharness: 2016-10-01 01:50:00.755182Z] Finished run-tests step (success) 18:50:00 INFO - Running post-run listener: _resource_record_post_run 18:50:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393428992; Read time: 312; Write time: 408028 18:50:00 INFO - TinderboxPrint: CPU usage
13.5% 18:50:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 312 18:50:00 INFO - TinderboxPrint: I/O write bytes / time
393,428,992 / 408,028 18:50:00 INFO - TinderboxPrint: CPU idle
8,235.1 (86.5%) 18:50:00 INFO - TinderboxPrint: CPU user
1,223.2 (12.8%) 18:50:00 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103743488; Read time: 0; Write time: 129824 18:50:00 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 4096; Write bytes: 289685504; Read time: 300; Write time: 278204 18:50:01 INFO - Running post-run listener: _upload_blobber_files 18:50:01 INFO - Blob upload gear active. 18:50:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:01 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 18:50:01 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'] 18:50:01 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 18:50:01 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:03 INFO - (blobuploader) - INFO - Done attempting. 18:50:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:06 INFO - (blobuploader) - INFO - Done attempting. 18:50:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:07 INFO - (blobuploader) - INFO - Done attempting. 18:50:07 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:07 INFO - Return code: 0 18:50:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5f21f12c62c1a81ad248ceee7c5e37abdb552e6f19cdf92f150f9e0093469b4a632c92a4b5786ca6cd7e5a2b7a1f6f87ed5d437346bba59a4206afe9a4d52e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c42f7f6001011eca72634401a78b291047f86c93d976f02fd99495a7f25044fad7f5ee87c9fcc0fb2e5da0854923364a8d10744be30d79e06997594f47c6585d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebd77d4bb31e1f6b317bf801927bc426e47e63a2adfb4c2b2519e863507095c04e7f39ecf8b26e6111f16c424fe04be8d5c214efb8a041686b269b54e6cfdfe4"} 18:50:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:07 INFO - Contents: 18:50:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5f21f12c62c1a81ad248ceee7c5e37abdb552e6f19cdf92f150f9e0093469b4a632c92a4b5786ca6cd7e5a2b7a1f6f87ed5d437346bba59a4206afe9a4d52e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c42f7f6001011eca72634401a78b291047f86c93d976f02fd99495a7f25044fad7f5ee87c9fcc0fb2e5da0854923364a8d10744be30d79e06997594f47c6585d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebd77d4bb31e1f6b317bf801927bc426e47e63a2adfb4c2b2519e863507095c04e7f39ecf8b26e6111f16c424fe04be8d5c214efb8a041686b269b54e6cfdfe4"} 18:50:07 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:07 INFO - Copying logs to upload dir... 18:50:07 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.444720 ========= master_lag: 142.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2016-09-30 18:52:29.252747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-30 18:52:29.256140) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5f21f12c62c1a81ad248ceee7c5e37abdb552e6f19cdf92f150f9e0093469b4a632c92a4b5786ca6cd7e5a2b7a1f6f87ed5d437346bba59a4206afe9a4d52e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c42f7f6001011eca72634401a78b291047f86c93d976f02fd99495a7f25044fad7f5ee87c9fcc0fb2e5da0854923364a8d10744be30d79e06997594f47c6585d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebd77d4bb31e1f6b317bf801927bc426e47e63a2adfb4c2b2519e863507095c04e7f39ecf8b26e6111f16c424fe04be8d5c214efb8a041686b269b54e6cfdfe4"} build_url:https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5f21f12c62c1a81ad248ceee7c5e37abdb552e6f19cdf92f150f9e0093469b4a632c92a4b5786ca6cd7e5a2b7a1f6f87ed5d437346bba59a4206afe9a4d52e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c42f7f6001011eca72634401a78b291047f86c93d976f02fd99495a7f25044fad7f5ee87c9fcc0fb2e5da0854923364a8d10744be30d79e06997594f47c6585d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebd77d4bb31e1f6b317bf801927bc426e47e63a2adfb4c2b2519e863507095c04e7f39ecf8b26e6111f16c424fe04be8d5c214efb8a041686b269b54e6cfdfe4"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-30 18:52:30.272631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:52:30.272938) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475285367.977954-1412338474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:52:30.461770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 18:52:30.462085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 18:52:30.472716) ========= ========= Total master_lag: 143.54 =========