builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1475753479.23 results: success (0) buildid: 20161006003024 builduid: a67e732015064e2cafe1a3c78adfb9fb revision: 1d7748535fa370332623ac29e50dd19e1ef6133b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.231480) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.231880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.232181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.250489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.250864) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 04:31:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.4M=0s 2016-10-06 04:31:20 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.445963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.449322) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013791 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.499043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:19.499406) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d7748535fa370332623ac29e50dd19e1ef6133b --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 1d7748535fa370332623ac29e50dd19e1ef6133b --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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 04:31:20,458 truncating revision to first 12 chars 2016-10-06 04:31:20,459 Setting DEBUG logging. 2016-10-06 04:31:20,459 attempt 1/10 2016-10-06 04:31:20,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d7748535fa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 04:31:20,805 unpacking tar archive at: fx-team-1d7748535fa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:20.170546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:20.170852) ========= script_repo_revision: 1d7748535fa370332623ac29e50dd19e1ef6133b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:20.171252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:20.171523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:31:20.181471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-06 04:31:20.181842) ========= /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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:21 INFO - MultiFileLogger online at 20161006 04:31:21 in /builds/slave/test 04:31:21 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 04:31:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:21 INFO - {'append_to_log': False, 04:31:21 INFO - 'base_work_dir': '/builds/slave/test', 04:31:21 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:21 INFO - 'branch': 'Fx-Team', 04:31:21 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:21 INFO - 'config_files': ('talos/linux_config.py',), 04:31:21 INFO - 'default_actions': ('clobber', 04:31:21 INFO - 'read-buildbot-config', 04:31:21 INFO - 'download-and-extract', 04:31:21 INFO - 'populate-webroot', 04:31:21 INFO - 'create-virtualenv', 04:31:21 INFO - 'install', 04:31:21 INFO - 'run-tests'), 04:31:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:21 INFO - 'download_minidump_stackwalk': True, 04:31:21 INFO - 'download_symbols': 'ondemand', 04:31:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:21 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:21 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:21 INFO - 'installer_path': 'installer.exe', 04:31:21 INFO - 'log_level': 'info', 04:31:21 INFO - 'log_name': 'talos', 04:31:21 INFO - 'log_to_console': True, 04:31:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:21 INFO - 'opt_config_files': (), 04:31:21 INFO - 'pip_index': False, 04:31:21 INFO - 'sps_profile': False, 04:31:21 INFO - 'sps_profile_interval': 0, 04:31:21 INFO - 'suite': 'dromaeojs-e10s', 04:31:21 INFO - 'system_bits': '32', 04:31:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:21 INFO - 'title': 'talos-linux64-ix-055', 04:31:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:21 INFO - 'use_talos_json': True, 04:31:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:21 INFO - 'work_dir': 'build'} 04:31:21 INFO - [mozharness: 2016-10-06 11:31:21.243596Z] Running clobber step. 04:31:21 INFO - Running pre-action listener: _resource_record_pre_action 04:31:21 INFO - Running main action method: clobber 04:31:21 INFO - rmtree: /builds/slave/test/build 04:31:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:22 INFO - Running post-action listener: _resource_record_post_action 04:31:22 INFO - [mozharness: 2016-10-06 11:31:22.219675Z] Finished clobber step (success) 04:31:22 INFO - [mozharness: 2016-10-06 11:31:22.219775Z] Running read-buildbot-config step. 04:31:22 INFO - Running pre-action listener: _resource_record_pre_action 04:31:22 INFO - Running main action method: read_buildbot_config 04:31:22 INFO - Using buildbot properties: 04:31:22 INFO - { 04:31:22 INFO - "project": "", 04:31:22 INFO - "product": "firefox", 04:31:22 INFO - "script_repo_revision": "production", 04:31:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:31:22 INFO - "repository": "", 04:31:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:31:22 INFO - "buildid": "20161006003024", 04:31:22 INFO - "pgo_build": "True", 04:31:22 INFO - "basedir": "/builds/slave/test", 04:31:22 INFO - "buildnumber": 801, 04:31:22 INFO - "slavename": "talos-linux64-ix-055", 04:31:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:31:22 INFO - "platform": "ubuntu64_hw", 04:31:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:31:22 INFO - "branch": "fx-team", 04:31:22 INFO - "repo_path": "integration/fx-team", 04:31:22 INFO - "revision": "1d7748535fa370332623ac29e50dd19e1ef6133b", 04:31:22 INFO - "stage_platform": "linux64-pgo", 04:31:22 INFO - "builduid": "a67e732015064e2cafe1a3c78adfb9fb", 04:31:22 INFO - "slavebuilddir": "test" 04:31:22 INFO - } 04:31:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:31:22 INFO - Running post-action listener: _resource_record_post_action 04:31:22 INFO - [mozharness: 2016-10-06 11:31:22.222199Z] Finished read-buildbot-config step (success) 04:31:22 INFO - [mozharness: 2016-10-06 11:31:22.222288Z] Running download-and-extract step. 04:31:22 INFO - Running pre-action listener: _resource_record_pre_action 04:31:22 INFO - Running main action method: download_and_extract 04:31:22 INFO - mkdir: /builds/slave/test/build/tests 04:31:22 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')]} 04:31:22 INFO - trying https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:31:23 INFO - Downloaded 1361 bytes. 04:31:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:31:23 INFO - Using the following test package requirements: 04:31:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'jsshell-linux-x86_64.zip'], 04:31:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:23 INFO - Http code: 200 04:31:23 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 04:31:23 INFO - x-amz-cf-id: gz4jALV3cwP45VmIe57KFD_d2fwsg_OdNq057-fvXo00iMpf3Y5Lfg== 04:31:23 INFO - x-amz-version-id: Rt_cgyMdppAvCJYGJEmVRMDhBHH_Gk2e 04:31:23 INFO - Expected file size: 21993014 04:31:23 INFO - Obtained file size: 21993014 04:31:28 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 04:31:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:31:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:28 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:28 INFO - Http code: 200 04:31:28 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 04:31:28 INFO - x-amz-cf-id: _YNEEV_SaUfkioKgILUxpZf3qITwIBAwDa8w_l3MoeTrolUuKvvy7g== 04:31:28 INFO - x-amz-version-id: Rt_cgyMdppAvCJYGJEmVRMDhBHH_Gk2e 04:31:28 INFO - Expected file size: 21993014 04:31:28 INFO - Obtained file size: 21993014 04:31:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:33 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:31:33 INFO - Http code: 200 04:31:33 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 04:31:33 INFO - x-amz-cf-id: 1P4IHebvcIVqsA9FqgGz_khii6aVui6hBPMSNM8oK-U1CNxUhrOFOw== 04:31:33 INFO - x-amz-version-id: ZeZQzzg5ox6kfGTe6kvd8DYvN8yexp45 04:31:33 INFO - Expected file size: 14409006 04:31:33 INFO - Obtained file size: 14409006 04:31:34 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')]} 04:31:34 INFO - trying https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:31:35 INFO - Downloaded 59704986 bytes. 04:31:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:35 INFO - mkdir: /builds/slave/test/properties 04:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:35 INFO - Contents: 04:31:35 INFO - build_url:https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:36 INFO - Running post-action listener: _resource_record_post_action 04:31:36 INFO - Running post-action listener: set_extra_try_arguments 04:31:36 INFO - [mozharness: 2016-10-06 11:31:36.148528Z] Finished download-and-extract step (success) 04:31:36 INFO - [mozharness: 2016-10-06 11:31:36.148826Z] Running populate-webroot step. 04:31:36 INFO - Running pre-action listener: _resource_record_pre_action 04:31:36 INFO - Running main action method: populate_webroot 04:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:36 INFO - '--tppagecycles', 04:31:36 INFO - '7'], 04:31:36 INFO - 'tests': ['tsvgm']}}, 04:31:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['damp', 'tps']}, 04:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'tests': ['damp', 'tps']}, 04:31:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['dromaeo_dom']}, 04:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['basic_compositor_video']}, 04:31:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['a11yr', 04:31:36 INFO - 'ts_paint', 04:31:36 INFO - 'tpaint', 04:31:36 INFO - 'sessionrestore', 04:31:36 INFO - 'sessionrestore_no_auto_restore', 04:31:36 INFO - 'tabpaint']}, 04:31:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['tsvgx', 04:31:36 INFO - 'tsvgr_opacity', 04:31:36 INFO - 'tart', 04:31:36 INFO - 'tscrollx', 04:31:36 INFO - 'cart']}, 04:31:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:36 INFO - 'tsvgr_opacity', 04:31:36 INFO - 'tart', 04:31:36 INFO - 'tscrollx', 04:31:36 INFO - 'cart']}, 04:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'talos_options': ['--disable-e10s'], 04:31:36 INFO - 'tests': ['tp5o']}, 04:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'tests': ['tp5o']}, 04:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'talos_options': ['--disable-e10s', 04:31:36 INFO - '--xperf_path', 04:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:36 INFO - 'tests': ['tp5n']}, 04:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:36 INFO - 'talos_options': ['--xperf_path', 04:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:36 INFO - 'tests': ['tp5n']}}, 04:31:36 INFO - 'talos.zip': {'path': '', 04:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:36 INFO - Running post-action listener: _resource_record_post_action 04:31:36 INFO - [mozharness: 2016-10-06 11:31:36.167544Z] Finished populate-webroot step (success) 04:31:36 INFO - [mozharness: 2016-10-06 11:31:36.167637Z] Running create-virtualenv step. 04:31:36 INFO - Running pre-action listener: _resource_record_pre_action 04:31:36 INFO - Running main action method: create_virtualenv 04:31:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:36 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 04:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:36 INFO - Using real prefix '/usr' 04:31:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:38 INFO - Installing pip.................done. 04:31:38 INFO - Return code: 0 04:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:38 INFO - Reading from file tmpfile_stdout 04:31:38 INFO - Output received: 04:31:38 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) 04:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:38 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:38 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 04:31:38 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 04:31:38 INFO - Using env: {'DISPLAY': ':0', 04:31:38 INFO - 'HOME': '/home/cltbld', 04:31:38 INFO - 'LANG': 'en_US.UTF-8', 04:31:38 INFO - 'LANGUAGE': 'en_US:en', 04:31:38 INFO - 'LOGNAME': 'cltbld', 04:31:38 INFO - 'MAIL': '/var/mail/cltbld', 04:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:38 INFO - 'MOZ_NO_REMOTE': '1', 04:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:38 INFO - 'NO_EM_RESTART': '1', 04:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:38 INFO - 'PWD': '/builds/slave/test', 04:31:38 INFO - 'SHELL': '/bin/bash', 04:31:38 INFO - 'SHLVL': '1', 04:31:38 INFO - 'TERM': 'linux', 04:31:38 INFO - 'TMOUT': '86400', 04:31:38 INFO - 'USER': 'cltbld', 04:31:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:38 INFO - '_': '/tools/buildbot/bin/python'} 04:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:39 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 04:31:39 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:39 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')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 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')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:39 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 04:31:39 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 04:31:39 INFO - Using env: {'DISPLAY': ':0', 04:31:39 INFO - 'HOME': '/home/cltbld', 04:31:39 INFO - 'LANG': 'en_US.UTF-8', 04:31:39 INFO - 'LANGUAGE': 'en_US:en', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MAIL': '/var/mail/cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SHLVL': '1', 04:31:39 INFO - 'TERM': 'linux', 04:31:39 INFO - 'TMOUT': '86400', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - '_': '/tools/buildbot/bin/python'} 04:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:39 INFO - Downloading/unpacking psutil>=3.1.1 04:31:39 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 04:31:39 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 04:31:39 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 04:31:39 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 04:31:39 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 04:31:39 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 04:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:41 INFO - Installing collected packages: psutil 04:31:41 INFO - Running setup.py install for psutil 04:31:41 INFO - building 'psutil._psutil_linux' extension 04:31:41 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 04:31:41 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 04:31:41 INFO - building 'psutil._psutil_posix' extension 04:31:41 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 04:31:41 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 04:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:41 INFO - Successfully installed psutil 04:31:41 INFO - Cleaning up... 04:31:41 INFO - Return code: 0 04:31:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:41 INFO - Using env: {'DISPLAY': ':0', 04:31:41 INFO - 'HOME': '/home/cltbld', 04:31:41 INFO - 'LANG': 'en_US.UTF-8', 04:31:41 INFO - 'LANGUAGE': 'en_US:en', 04:31:41 INFO - 'LOGNAME': 'cltbld', 04:31:41 INFO - 'MAIL': '/var/mail/cltbld', 04:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:41 INFO - 'MOZ_NO_REMOTE': '1', 04:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:41 INFO - 'NO_EM_RESTART': '1', 04:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:41 INFO - 'PWD': '/builds/slave/test', 04:31:41 INFO - 'SHELL': '/bin/bash', 04:31:41 INFO - 'SHLVL': '1', 04:31:41 INFO - 'TERM': 'linux', 04:31:41 INFO - 'TMOUT': '86400', 04:31:41 INFO - 'USER': 'cltbld', 04:31:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:41 INFO - '_': '/tools/buildbot/bin/python'} 04:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:44 INFO - Installing collected packages: mozsystemmonitor 04:31:44 INFO - Running setup.py install for mozsystemmonitor 04:31:44 INFO - Successfully installed mozsystemmonitor 04:31:44 INFO - Cleaning up... 04:31:44 INFO - Return code: 0 04:31:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:44 INFO - Using env: {'DISPLAY': ':0', 04:31:44 INFO - 'HOME': '/home/cltbld', 04:31:44 INFO - 'LANG': 'en_US.UTF-8', 04:31:44 INFO - 'LANGUAGE': 'en_US:en', 04:31:44 INFO - 'LOGNAME': 'cltbld', 04:31:44 INFO - 'MAIL': '/var/mail/cltbld', 04:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:44 INFO - 'MOZ_NO_REMOTE': '1', 04:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:44 INFO - 'NO_EM_RESTART': '1', 04:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:44 INFO - 'PWD': '/builds/slave/test', 04:31:44 INFO - 'SHELL': '/bin/bash', 04:31:44 INFO - 'SHLVL': '1', 04:31:44 INFO - 'TERM': 'linux', 04:31:44 INFO - 'TMOUT': '86400', 04:31:44 INFO - 'USER': 'cltbld', 04:31:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:44 INFO - '_': '/tools/buildbot/bin/python'} 04:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:46 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 04:31:46 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 04:31:46 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 04:31:46 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 04:31:46 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 04:31:46 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 04:31:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:46 INFO - warning: no files found matching '*.txt' 04:31:46 INFO - no previously-included directories found matching 'build' 04:31:46 INFO - no previously-included directories found matching 'dist' 04:31:46 INFO - no previously-included directories found matching '.git*' 04:31:46 INFO - Installing collected packages: jsonschema, functools32 04:31:46 INFO - Running setup.py install for functools32 04:31:46 INFO - warning: no files found matching '*.txt' 04:31:46 INFO - no previously-included directories found matching 'build' 04:31:46 INFO - no previously-included directories found matching 'dist' 04:31:46 INFO - no previously-included directories found matching '.git*' 04:31:46 INFO - Successfully installed jsonschema functools32 04:31:46 INFO - Cleaning up... 04:31:46 INFO - Return code: 0 04:31:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', '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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31: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 functools32==3.2.3-2 04:31:46 INFO - Using env: {'DISPLAY': ':0', 04:31:46 INFO - 'HOME': '/home/cltbld', 04:31:46 INFO - 'LANG': 'en_US.UTF-8', 04:31:46 INFO - 'LANGUAGE': 'en_US:en', 04:31:46 INFO - 'LOGNAME': 'cltbld', 04:31:46 INFO - 'MAIL': '/var/mail/cltbld', 04:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:46 INFO - 'MOZ_NO_REMOTE': '1', 04:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:46 INFO - 'NO_EM_RESTART': '1', 04:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:46 INFO - 'PWD': '/builds/slave/test', 04:31:46 INFO - 'SHELL': '/bin/bash', 04:31:46 INFO - 'SHLVL': '1', 04:31:46 INFO - 'TERM': 'linux', 04:31:46 INFO - 'TMOUT': '86400', 04:31:46 INFO - 'USER': 'cltbld', 04:31:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:46 INFO - '_': '/tools/buildbot/bin/python'} 04:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:47 INFO - Cleaning up... 04:31:47 INFO - Return code: 0 04:31:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', '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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31: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 blobuploader==1.2.4 04:31:47 INFO - Using env: {'DISPLAY': ':0', 04:31:47 INFO - 'HOME': '/home/cltbld', 04:31:47 INFO - 'LANG': 'en_US.UTF-8', 04:31:47 INFO - 'LANGUAGE': 'en_US:en', 04:31:47 INFO - 'LOGNAME': 'cltbld', 04:31:47 INFO - 'MAIL': '/var/mail/cltbld', 04:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:47 INFO - 'MOZ_NO_REMOTE': '1', 04:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:47 INFO - 'NO_EM_RESTART': '1', 04:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:47 INFO - 'PWD': '/builds/slave/test', 04:31:47 INFO - 'SHELL': '/bin/bash', 04:31:47 INFO - 'SHLVL': '1', 04:31:47 INFO - 'TERM': 'linux', 04:31:47 INFO - 'TMOUT': '86400', 04:31:47 INFO - 'USER': 'cltbld', 04:31:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:47 INFO - '_': '/tools/buildbot/bin/python'} 04:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - Downloading docopt-0.6.1.tar.gz 04:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:50 INFO - Running setup.py install for blobuploader 04:31:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:50 INFO - Running setup.py install for requests 04:31:50 INFO - Running setup.py install for docopt 04:31:50 INFO - Successfully installed blobuploader requests docopt 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:50 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 04:31:50 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 04:31:50 INFO - Using env: {'DISPLAY': ':0', 04:31:50 INFO - 'HOME': '/home/cltbld', 04:31:50 INFO - 'LANG': 'en_US.UTF-8', 04:31:50 INFO - 'LANGUAGE': 'en_US:en', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MAIL': '/var/mail/cltbld', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SHLVL': '1', 04:31:50 INFO - 'TERM': 'linux', 04:31:50 INFO - 'TMOUT': '86400', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - '_': '/tools/buildbot/bin/python'} 04:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:50 INFO - Running setup.py (path:/tmp/pip-08P4Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:50 INFO - Running setup.py (path:/tmp/pip-wjeYaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:50 INFO - Running setup.py (path:/tmp/pip-HOb0RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:51 INFO - Running setup.py (path:/tmp/pip-urHaNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:51 INFO - Running setup.py (path:/tmp/pip-5UGKam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:51 INFO - Running setup.py (path:/tmp/pip-GA3Xmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:51 INFO - Running setup.py (path:/tmp/pip-O_kB1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:51 INFO - Running setup.py (path:/tmp/pip-f8XOsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:51 INFO - Running setup.py (path:/tmp/pip-dFedJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:51 INFO - Running setup.py (path:/tmp/pip-uKmnqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:51 INFO - Running setup.py (path:/tmp/pip-HCeYQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:51 INFO - Running setup.py (path:/tmp/pip-wDhqS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:51 INFO - Running setup.py (path:/tmp/pip-EH_4zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:51 INFO - Running setup.py (path:/tmp/pip-gN_Mfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:51 INFO - Running setup.py (path:/tmp/pip-onmHxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:51 INFO - Running setup.py (path:/tmp/pip-WkdFAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:52 INFO - Running setup.py (path:/tmp/pip-Xys36a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:52 INFO - Running setup.py install for manifestparser 04:31:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Running setup.py install for mozcrash 04:31:52 INFO - Running setup.py install for mozdebug 04:31:52 INFO - Running setup.py install for mozdevice 04:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Running setup.py install for mozfile 04:31:52 INFO - Running setup.py install for mozhttpd 04:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Running setup.py install for mozinfo 04:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Running setup.py install for mozInstall 04:31:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:52 INFO - Running setup.py install for mozleak 04:31:52 INFO - Running setup.py install for mozlog 04:31:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Running setup.py install for moznetwork 04:31:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Running setup.py install for mozprocess 04:31:53 INFO - Running setup.py install for mozprofile 04:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Running setup.py install for mozrunner 04:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Running setup.py install for mozscreenshot 04:31:53 INFO - Running setup.py install for moztest 04:31:53 INFO - Running setup.py install for mozversion 04:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:53 INFO - Cleaning up... 04:31:53 INFO - Return code: 0 04:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:53 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 04:31:53 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 04:31:53 INFO - Using env: {'DISPLAY': ':0', 04:31:53 INFO - 'HOME': '/home/cltbld', 04:31:53 INFO - 'LANG': 'en_US.UTF-8', 04:31:53 INFO - 'LANGUAGE': 'en_US:en', 04:31:53 INFO - 'LOGNAME': 'cltbld', 04:31:53 INFO - 'MAIL': '/var/mail/cltbld', 04:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:53 INFO - 'MOZ_NO_REMOTE': '1', 04:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:53 INFO - 'NO_EM_RESTART': '1', 04:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:53 INFO - 'PWD': '/builds/slave/test', 04:31:53 INFO - 'SHELL': '/bin/bash', 04:31:53 INFO - 'SHLVL': '1', 04:31:53 INFO - 'TERM': 'linux', 04:31:53 INFO - 'TMOUT': '86400', 04:31:53 INFO - 'USER': 'cltbld', 04:31:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:53 INFO - '_': '/tools/buildbot/bin/python'} 04:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:54 INFO - Running setup.py (path:/tmp/pip-_ux5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:54 INFO - Running setup.py (path:/tmp/pip-gJhQfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:54 INFO - Running setup.py (path:/tmp/pip-V_QJ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:54 INFO - Running setup.py (path:/tmp/pip-1MXzUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:54 INFO - Running setup.py (path:/tmp/pip-mnIJ7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:54 INFO - Running setup.py (path:/tmp/pip-cxXyiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:54 INFO - Running setup.py (path:/tmp/pip-BveIqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:54 INFO - Running setup.py (path:/tmp/pip-8OKXnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:54 INFO - Running setup.py (path:/tmp/pip-8H0Ecl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:54 INFO - Running setup.py (path:/tmp/pip-bnAGiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:54 INFO - Running setup.py (path:/tmp/pip-tb4M1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:54 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)) 04:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:54 INFO - Running setup.py (path:/tmp/pip-EgsPfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:55 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)) 04:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:55 INFO - Running setup.py (path:/tmp/pip-L9ylI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:55 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)) 04:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:55 INFO - Running setup.py (path:/tmp/pip-NkdnmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:55 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)) 04:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:55 INFO - Running setup.py (path:/tmp/pip-tX88ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:55 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)) 04:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:55 INFO - Running setup.py (path:/tmp/pip-ceJUZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:55 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)) 04:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:55 INFO - Running setup.py (path:/tmp/pip-BhzDeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:55 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)) 04:31:55 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)) 04:31:55 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)) 04:31:55 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)) 04:31:55 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)) 04:31:55 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)) 04:31:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:57 INFO - Downloading blessings-1.6.tar.gz 04:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:57 INFO - Installing collected packages: blessings 04:31:57 INFO - Running setup.py install for blessings 04:31:57 INFO - Successfully installed blessings 04:31:57 INFO - Cleaning up... 04:31:57 INFO - Return code: 0 04:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:57 INFO - Reading from file tmpfile_stdout 04:31:57 INFO - Current package versions: 04:31:57 INFO - argparse == 1.2.1 04:31:57 INFO - blessings == 1.6 04:31:57 INFO - blobuploader == 1.2.4 04:31:57 INFO - docopt == 0.6.1 04:31:57 INFO - functools32 == 3.2.3-2 04:31:57 INFO - jsonschema == 2.5.1 04:31:57 INFO - manifestparser == 1.1 04:31:57 INFO - mozInstall == 1.12 04:31:57 INFO - mozcrash == 0.17 04:31:57 INFO - mozdebug == 0.1 04:31:57 INFO - mozdevice == 0.48 04:31:57 INFO - mozfile == 1.2 04:31:57 INFO - mozhttpd == 0.7 04:31:57 INFO - mozinfo == 0.9 04:31:57 INFO - mozleak == 0.1 04:31:57 INFO - mozlog == 3.4 04:31:57 INFO - moznetwork == 0.27 04:31:57 INFO - mozprocess == 0.23 04:31:57 INFO - mozprofile == 0.28 04:31:57 INFO - mozrunner == 6.12 04:31:57 INFO - mozscreenshot == 0.1 04:31:57 INFO - mozsystemmonitor == 0.3 04:31:57 INFO - moztest == 0.7 04:31:57 INFO - mozversion == 1.4 04:31:57 INFO - psutil == 3.1.1 04:31:57 INFO - requests == 1.2.3 04:31:57 INFO - wsgiref == 0.1.2 04:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:57 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')]} 04:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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')]} 04:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:57 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 04:31:57 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 04:31:57 INFO - Using env: {'DISPLAY': ':0', 04:31:57 INFO - 'HOME': '/home/cltbld', 04:31:57 INFO - 'LANG': 'en_US.UTF-8', 04:31:57 INFO - 'LANGUAGE': 'en_US:en', 04:31:57 INFO - 'LOGNAME': 'cltbld', 04:31:57 INFO - 'MAIL': '/var/mail/cltbld', 04:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:57 INFO - 'MOZ_NO_REMOTE': '1', 04:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:57 INFO - 'NO_EM_RESTART': '1', 04:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:57 INFO - 'PWD': '/builds/slave/test', 04:31:57 INFO - 'SHELL': '/bin/bash', 04:31:57 INFO - 'SHLVL': '1', 04:31:57 INFO - 'TERM': 'linux', 04:31:57 INFO - 'TMOUT': '86400', 04:31:57 INFO - 'USER': 'cltbld', 04:31:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:57 INFO - '_': '/tools/buildbot/bin/python'} 04:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 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)) 04:31:57 INFO - Cleaning up... 04:31:57 INFO - Return code: 0 04:31:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:57 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')]} 04:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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')]} 04:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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 0x7ff0a46cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', '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 04:31:57 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 04:31:57 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 04:31:57 INFO - Using env: {'DISPLAY': ':0', 04:31:57 INFO - 'HOME': '/home/cltbld', 04:31:57 INFO - 'LANG': 'en_US.UTF-8', 04:31:57 INFO - 'LANGUAGE': 'en_US:en', 04:31:58 INFO - 'LOGNAME': 'cltbld', 04:31:58 INFO - 'MAIL': '/var/mail/cltbld', 04:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:58 INFO - 'MOZ_NO_REMOTE': '1', 04:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:58 INFO - 'NO_EM_RESTART': '1', 04:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:58 INFO - 'PWD': '/builds/slave/test', 04:31:58 INFO - 'SHELL': '/bin/bash', 04:31:58 INFO - 'SHLVL': '1', 04:31:58 INFO - 'TERM': 'linux', 04:31:58 INFO - 'TMOUT': '86400', 04:31:58 INFO - 'USER': 'cltbld', 04:31:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:58 INFO - '_': '/tools/buildbot/bin/python'} 04:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:58 INFO - Cleaning up... 04:31:58 INFO - Return code: 0 04:31:58 INFO - Running post-action listener: _resource_record_post_action 04:31:58 INFO - Running post-action listener: _start_resource_monitoring 04:31:58 INFO - Starting resource monitoring. 04:31:58 INFO - [mozharness: 2016-10-06 11:31:58.238985Z] Finished create-virtualenv step (success) 04:31:58 INFO - [mozharness: 2016-10-06 11:31:58.239442Z] Running install step. 04:31:58 INFO - Running pre-action listener: _resource_record_pre_action 04:31:58 INFO - Running main action method: install 04:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:58 INFO - Reading from file tmpfile_stdout 04:31:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:58 INFO - Reading from file tmpfile_stdout 04:31:58 INFO - Output received: 04:31:58 INFO - Usage: mozinstall [options] installer 04:31:58 INFO - Options: 04:31:58 INFO - -h, --help show this help message and exit 04:31:58 INFO - -d DEST, --destination=DEST 04:31:58 INFO - Directory to install application into. [default: 04:31:58 INFO - "/builds/slave/test"] 04:31:58 INFO - --app=APP Application being installed. [default: firefox] 04:31:58 INFO - mkdir: /builds/slave/test/build/application 04:31:58 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'] 04:31:58 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 04:32:16 INFO - Reading from file tmpfile_stdout 04:32:16 INFO - Output received: 04:32:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:16 INFO - Running post-action listener: _resource_record_post_action 04:32:16 INFO - [mozharness: 2016-10-06 11:32:16.115228Z] Finished install step (success) 04:32:16 INFO - [mozharness: 2016-10-06 11:32:16.115473Z] Running run-tests step. 04:32:16 INFO - Running pre-action listener: _resource_record_pre_action 04:32:16 INFO - Running main action method: run_tests 04:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:16 INFO - Python 2.7.3 04:32:16 INFO - Return code: 0 04:32:16 INFO - grabbing minidump binary from tooltool 04:32:16 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')]} 04:32:16 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 0xe45930>, '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 0xe46830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:16 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 04:32:16 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 04:32:16 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 04:32:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:16 INFO - Return code: 0 04:32:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:16 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:32:16 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 04:32:16 INFO - Using env: {'DISPLAY': ':0', 04:32:16 INFO - 'HOME': '/home/cltbld', 04:32:16 INFO - 'LANG': 'en_US.UTF-8', 04:32:16 INFO - 'LANGUAGE': 'en_US:en', 04:32:16 INFO - 'LOGNAME': 'cltbld', 04:32:16 INFO - 'MAIL': '/var/mail/cltbld', 04:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:16 INFO - 'MOZ_NO_REMOTE': '1', 04:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:16 INFO - 'NO_EM_RESTART': '1', 04:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:16 INFO - 'PWD': '/builds/slave/test', 04:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:16 INFO - 'SHELL': '/bin/bash', 04:32:16 INFO - 'SHLVL': '1', 04:32:16 INFO - 'TERM': 'linux', 04:32:16 INFO - 'TMOUT': '86400', 04:32:16 INFO - 'USER': 'cltbld', 04:32:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750', 04:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:16 INFO - '_': '/tools/buildbot/bin/python'} 04:32:16 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:32:16 INFO - mozversion application_buildid: 20161006003024 04:32:16 INFO - mozversion application_changeset: 1d7748535fa370332623ac29e50dd19e1ef6133b 04:32:16 INFO - mozversion application_display_name: Nightly 04:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:16 INFO - mozversion application_name: Firefox 04:32:16 INFO - mozversion application_remotingname: firefox 04:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:32:16 INFO - mozversion application_vendor: Mozilla 04:32:16 INFO - mozversion application_version: 52.0a1 04:32:16 INFO - mozversion platform_buildid: 20161006003024 04:32:16 INFO - mozversion platform_changeset: 1d7748535fa370332623ac29e50dd19e1ef6133b 04:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:32:16 INFO - mozversion platform_version: 52.0a1 04:32:16 INFO - using testdate: 1475753536 04:32:16 INFO - actual date: 1475753536 04:32:16 INFO - starting webserver on 'localhost:47896' 04:32:16 INFO - SUITE-START | Running 2 tests 04:32:16 INFO - TEST-START | dromaeo_css 04:32:16 INFO - operating with platform_type : linux_ 04:32:16 INFO - Initialising browser for dromaeo_css test... 04:32:16 INFO - TEST-INFO | started process 10011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNyeicd/profile http://localhost:47896/getInfo.html) 04:32:20 INFO - PROCESS | 10011 | __metrics Screen width/height:1600/1200 04:32:20 INFO - PROCESS | 10011 | colorDepth:24 04:32:20 INFO - PROCESS | 10011 | Browser inner width/height: 1024/697 04:32:20 INFO - PROCESS | 10011 | __metrics 04:32:21 ERROR - PROCESS | 10011 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 04:32:22 INFO - TEST-INFO | 10011: exit 0 04:32:22 INFO - Browser initialized. 04:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:22 INFO - TEST-INFO | started process 10133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNyeicd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:34 INFO - PROCESS | 10133 | RSS: Main: 185212928 04:32:34 INFO - PROCESS | 10133 | 04:33:23 INFO - PROCESS | 10133 | 1475753603840 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] 04:35:35 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47896/tests/dromaeo/cssquery-ext.html) 04:35:36 INFO - PROCESS | 10133 | RSS: Main: 200355840 04:35:36 INFO - PROCESS | 10133 | 04:38:38 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-ext.html (next: http://localhost:47896/tests/dromaeo/cssquery-jquery.html) 04:38:39 INFO - PROCESS | 10133 | RSS: Main: 197578752 04:38:39 INFO - PROCESS | 10133 | 04:41:41 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47896/tests/dromaeo/cssquery-mootools.html) 04:41:41 INFO - PROCESS | 10133 | RSS: Main: 198402048 04:41:41 INFO - PROCESS | 10133 | 04:44:43 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47896/tests/dromaeo/cssquery-prototype.html) 04:44:44 INFO - PROCESS | 10133 | RSS: Main: 194863104 04:44:44 INFO - PROCESS | 10133 | 04:47:46 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47896/tests/dromaeo/cssquery-yui.html) 04:47:47 INFO - PROCESS | 10133 | RSS: Main: 198729728 04:47:47 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | Cycle 1(1): loaded http://localhost:47896/tests/dromaeo/cssquery-yui.html (next: http://localhost:47896/tests/dromaeo/cssquery-dojo.html) 04:50:50 INFO - PROCESS | 10133 | RSS: Main: 198995968 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | __start_tp_report 04:50:50 INFO - PROCESS | 10133 | _x_x_mozilla_page_load 04:50:50 INFO - PROCESS | 10133 | _x_x_mozilla_page_load_details 04:50:50 INFO - PROCESS | 10133 | |i|pagename|runs| 04:50:50 INFO - PROCESS | 10133 | |0;dojo.html;2997.7002299770024;3018.973548993342;3034.0291106845802;3041.8326992015445;3052.236940764809;5106.234064890259;5254.500822421868;5348.5453736432355;5367.70477623731;5367.731613419328;5135.563477104451;5225.163973764198;5287.920681189786;5296.285001524793;5359.678419294835;4757.096151731177;4850.87872803181;4868.318435419044;4920.852374428773;4958.504149585049;4941.851744447655;4952.281919121725;4964.453910069889;4968.726720030397;4978.825741099062;4699.389079419688;4734.928976065362;4755.714657120584;4900.240462728283;4949.876253093666;4781.952180478185;4802.159622066124;4825.227963525854;4862.5623693867365;4873.122837889178;4728.361671174382;4767.189577771787;4791.520847915215;4796.136695394827;4824.6863953842885;5140.1518749406305;5178.689278643255;5236.659617124913;5248.71132087735;5268.631195816294;5608.158776183564;5617.410171931929;5620.185073164409;5621.971890140523;5623.550115990711;5648.039833228361;5656.151577263443;5657.9434205658235;5658.151277308396;5659.773609055633;5235;5285.233641122054;5292.629515933848;5293.41772405039;5294.947050529484;5704.600677952503;5735.598508104393;5745.2818397700285;5748.6838223898085;5761.3950535194035;5576.581756368289;5601.355844077902;5602.075657516546;5603.635763675348;5608.551315894719;5483.204935284361;5663.377028526858;5665.405132461115;5665.716714164275;5668.57485688575;5510.641808282448;5525.060739674265;5530.308711411074;5543.944560554342;5574.554035677136;5593.636413633182;5612.831615051555;5616.550675945915;5621.634593751393;5626.85932851682;4305.160493703697;4352.586504282088;4373.322135069069;4398.318260669601;4407.294832826797;3923.4899463070187;3926;3930.862419815293;3975.602439756059;3979.9403008954887;5485.402717236656;5499.917501237484;5510.311211098613;5519.806806761744;5559;5557.944420555743;5593;5625.746841392147;5787.652740835563;5794.478496935296;5331.840044798585;5390.54180394663;5402.135658294733;5437.45625437461;5456.045192091368;4900.068986892479;4906.90186196274;4908.558229759339;4928.802847886116;4966.230234313687;5724.198612194379;5773.134029895549;5854.268216473026;5857.619254748428;5866.12008198765;5710.942890571041;5722.6852523109965;5763.94236057634;5780.624259423124;5782.190493330853;5781.4218578141845;5856.443637854397;5921.230240068763;5921.289445266596;5921.970390148022;5418.051840927901;5573.247611572548;5573.944260557342;5605.243292155506;5610.354809196994;5567.081431563746;5663.631863928831;5739.253896993364;5773.942260577341;5779.913301300568;5562.694051827189;5566.888662226652;5568.638038527482;5573.219749235192;5574.9442505574425;5380.973095134499;5432.130859062531;5502.147167189092;5551.333839939233;5558.916616250679;5502.944970550243;5508.834734957958;5521.558275338044;5563.8887222256135;5578.135389014709;5568.248286481273;5572.414896435978;5610.242617246783;5614.578906581941;5628.183913332462;5389.434109418611;5435.456454354533;5507.449255074461;5508;5559.8888022240135 04:50:50 INFO - PROCESS | 10133 | |1;ext.html;567.0218872445033;568.8151350810986;574.5374973146616;584.6608966799257;586.331581996524;41655.37516937245;42709;42824.357634635424;46678;46681.766591167;43893.561064389345;44255.11489770203;44613.33080003803;44691.553084469146;44979.550204498024;8874.955625221864;9020.052894446088;9035.774105647346;9036.186743193111;9036.367454278203;8861.468311901306;8952.462852228855;8961.148690874388;8962.283017358595;8970.775730606754;8925.95537022314;8973.282137429023;9037.728868133967;9043.050479699636;9084.364094513387;8867.113288671146;8882.422642528247;8884.689035883777;8899.510526921016;8931.687390941352;8732.12678732128;8799.29605631548;8812.779680507974;8813.07462716412;8836.823263534758;41408.378874316906;41603.58396416058;41658.37512437316;41786.582134178876;42015.789921050506;3422.1273575238406;3459.135216195951;3611.693006094485;3752.5684546277253;4012.941111958575;30638;31026.328862394435;31107.377852442823;31613;31670.208244793834;4037.4347591337237;4057.1885622875543;4060.3909413587903;4092.2224777292518;4155.148194620096;301160;301222;302057;303708;304546;54629.1805622916;54787.72606136944;55049.44950550523;55074.17388739172;55117.44882551203;57607.423925761046;57772;57793;57882.42117578854;57997.42002580005;16608.169591520375;16658.83341166597;16750.74873876893;16869.325226990783;16873.662526749395;13071.477140914258;13181.077324587186;13235.602931912059;13253.072284940154;13264.73470530584;14996.775048374284;15540;15686.137262450446;15713.764293535605;15741.763873541906;5644.689542075143;5763.308402991668;5838.1242813577455;5844.47399734026;5905.940940590539;894.7518212094092;1001.1090129784498;1020.7703266764919;1096.2435919215716;1127.875933647298;30545.69454305473;30653.233669158002;31190.68809311923;31653.683463165533;31695;1062.9362238265574;1075.6719200643722;1085.978280434387;1138.5218208352512;1192.9582464613698;15537.844621553866;15948.681026379407;16098.839011609969;16138.67722645564;16181.786366022596;517519;525651;527668;530337;532774;53528;53955;54161.72919135379;54249.72875135599;54689.453105468434;1295.747329270802;1347.5148946379295;1362.7206422683525;1367.8221831161886;1391.5199256256576;28024.579631305955;29437.26406839846;29637.407251855275;29655.25861853471;30651;46503.069938601715;46539.30191047069;46554.53445465637;46866.35967741113;46961.76519117383;445769;447055;447329;447784;448620;26657.600135998364;26875.893580219697;27069.1879243623;27185.456290873677;27222.319442013315;42164.578354217294;44715.32927006033;46148.07703845971;46279;46450.070998580515;37708.62291377051;38118.61881381151;39154.6084539151;40206.798966004986;40698.79650601728;38919.805400972815;38934.415983759696;39109;39697.206055878145;40647.796761016005;38910.221795564496;40089.198216034936;40340.79829600833;40348.394774077824;40407.39388909227;33316.16709582183;35514;35620.46569301411;36012.45981310335;36250;27410.451790964467;27472.725272747015;27805;27840.60178730012;28008.71991280061 04:50:50 INFO - PROCESS | 10133 | |2;jquery.html;391.5986114232911;391.6025234387097;395.1839451532583;401.2196278238825;425.3555862867756;14727.410903563845;18539.536511587216;18923;19253.84476931385;19396;18177.909110454428;18296.90851545744;18836;19290.131944062516;19296;5528.115501519757;5677.37548869624;5794.68129252891;5822.184894114827;5875.88248235035;5550.111982082867;5821.18503409523;5841.912371314434;5856.238688970428;5865.120231965197;5850.6782126983;5959.225300710901;5962.940370596282;5972.611780234271;6006.159137720722;5780.82657520273;5855.385184555603;5907.940920590825;5964.433378829026;5990.8502287442725;5711.600187986843;5717.370549393445;5717.514011309044;5718.456746609066;5721.342045664718;13910.58268251954;14075.648108797259;14112.506062287874;14287.214203218819;18788.872667639986;2265.4676151104477;2277.908883644652;2320.6170981787986;2356.422676444282;2820;9378.85931711025;10025.799484010278;10028.94985525075;10398.168146548258;10418.895811041868;1856.5915498590423;1856.941543320308;1895.9052047397574;1946.464722201406;1958.412476257117;71332.6433367835;72027.27972720258;72748.27251727521;82810;86673.56663216707;10866.565337386415;10882.891171088346;10894.805499882445;11250.606228781953;11346.602868899548;12487.875121248853;13279.203247805162;15296.235188240544;15337.932413517117;15344.693106137815;7811.804704882424;7907.802304942307;7926.682932682744;8106.675732970733;8249.092599814016;7823.765287041398;8002.79993000168;8206.097329293772;8240.464369815943;8258.215469530385;4006.659433948147;4066.755994640331;4101.405296232089;4147.3778933159665;4223.113146239262;1912.235105957628;1921.5196200949763;1941.417574727576;1958.676818324989;2015.5968806238811;919.935604507678;971.2084651009404;999.6301368493704;1000.309786247487;1038.0190719769896;19156.137973791214;19407.417777466697;19585.902070489556;19593.216271349273;20053.39839804808;457.17708125374196;463.9420072490939;470.7881453346008;474.98575042748774;487.3080226078976;6140.8771824563255;6279.780207692709;6461.289258181596;6518.28298887122;6574.57265277765;325630;329182;367231;442018;473825;86453.56773216094;91991.54004229936;93450.53274733583;94419;95821;465.77875509133565;475.6575265808612;480.0686667864332;480.5050797678327;481.696531185351;10822.205208260919;11139.387333696724;11167.944160279147;11208.943955280172;11353.943230283796;36524.26951461009;37773;40825;41319.7934010328;41920.580794191665;54701.45298546964;56223.43776562182;57216.71391643015;57783.71108144432;59088.40911590829;8435.283000944988;8626.525541095049;8707.129287071242;8812.545929921747;8821.470711757058;11743.354115523387;12818.55135070268;12818.74362512726;13025.153365031243;13148.211107333591;10748.408837514013;11034.17243706709;11438.256513326607;11508.251963622337;11741.941290293495;11407.543698251977;11444.599439019594;11523.481443335239;11563.537458501902;11584.451420687436;11091.33451992883;11628;11629.88370116288;11644.6506604802;11792.823107653563;8054.516728996279;8336.666533338599;8525.275351594935;8628;9121;11405.315681058832;11458.541658333574;11470.247140686008;11703.882961170279;11928.165028447926 04:50:50 INFO - PROCESS | 10133 | |3;mootools.html;1462.3638717158033;1489.806325177727;1601.8638415734663;1734.1329335332334;1746.4324094669228;7796.1814009529035;8022.478538894982;8293.295069919057;9035.051319611444;9139.177474027345;8340.791480212998;8572.95713521433;8592.398532102756;8865.645374185026;8870.86693699595;2279.1453205048147;2291;2295.1966811615966;2303.401115709919;2303.6314189729646;2278.100150440575;2281.3384118605586;2324.2794733632545;2331.4521087544413;2339.4502291961376;2285.3486756274465;2335.5912715274844;2337.7194736631627;2338.976610233893;2352.788249057593;2290.977090229093;2295.494991101955;2297.0811675329833;2308.4459729664845;2308.953820923589;2253.774622537733;2270.579942710604;2273.102124660766;2285.371522831218;2286.416963674269;8865.734027979106;8953.865692014626;8960.507172105532;8970.686025989058;8992.415492993;5131.589472842164;5208.427073021964;5272.973635131838;5275.182346736224;5277.577793776489;3110.3623757129963;3183.108729555705;3323.102762254202;3361.596608407007;3373.325334933023;1091.399730148423;1092.595739576354;1121.7588218533056;1131.7396998690265;1158.5539567266578;12482.937585312015;12483.438245278985;12540.498380064786;12559.434825432878;12564.560240391635;4336.588024137765;4440.245158323093;4548.431446069241;4555.157295900269;4619.676622636383;10504.527296271686;10511.211659125596;10533.789324213472;10535.736606584744;10539.524466574685;5228.738563071907;5261.026710058652;5262.815801446931;5280.970210808932;5283.867903302371;4062.8374865005067;4194.769287689145;4683.086798074411;4836.105320515716;4854.077725232195;3719.8512059517316;3794.2411517696573;3809.8285577149095;3816.2749077675153;3931.6068393160454;1221.7617564574823;1232.4761976160096;1232.5932442294022;1236.0358920042381;1243.384524660299;783.902012248469;858.9828203435897;874.8906386701663;925.2459245714721;980.2501086668705;5619;5622.156676498558;5682.176084467729;5704.344000440003;5860.619059761102;459.9701019433726;464.4496271917788;468.6368064749846;473.862579851846;474.87178461815114;4112.753234805921;4127.442795222667;4147.274227010261;4160.1471698301775;4182.142660754538;10579.894201058045;10835.78328433427;10931.56273749057;10956.28784129029;10976.506057227443;10775.084117849914;10791.136709063256;10792.838107428395;10805.83791243132;10851.457427128613;7781.338586220121;8131.9593402032615;8135.6745730171315;8203.097659257477;8225.054118776417;6141.385861413823;6179.28938172098;6245.094461303176;6245.313015568375;6315.715792789428;10161.84757228657;10236.846447303147;10250.333728307636;10306;10313.793724125626;9356.532173391439;9742.220622350053;9765.707028789147;10016.899831001596;10066.396016239049;6984.825379365557;7161.641917904188;7389.556626602421;7816.84366312682;8033.236842499953;8412.495250285003;8794.472331660121;8808.86786698213;8810.779730506789;8816.338774592059;7486.812829679302;7610.200928902607;7619.885701714589;7716.575588342471;7749.883751743616;7159.892601610876;7387.482876198829;7392.149902761036;7587.58268295249;7602.50583712057;6830.692618832065;6960.965195173992;6968.860622787617;6978.302169782981;6997.685104170427;5049.495050494921;5212.452692467236;5254.842354729364;5438.510534051954;5513.3108361454815;5240.08298547745;5286.920696189637;5313.601479888946;5424.267723857229;5442.619016668795 04:50:50 INFO - PROCESS | 10133 | |4;prototype.html;302.25192648195707;316.33096001955863;323.705428060465;325.86639477814094;329.18855022369854;4956.553910148086;5192.443176424143;5453.64551304165;5467.835964921053;5468.425815289392;5288.867778305535;5379.139337705968;5429.619926605139;5433.011843486087;5448.618596698223;4297.162053399588;4298.290782020963;4302.935455968163;4318.546552611978;4320.25663703549;4108.77401742904;4269.487661480626;4285.700000999931;4288.52826189119;4306.858682449138;4212.1996820604145;4218.806220765216;4250.979764856427;4252.255855225339;4277.272863613178;4246.490421149451;4247.362895565659;4249.830006799724;4251.277282861905;4264.850730224427;3783.127351960797;3785.772853628791;3789.995651152447;3790.8104594770152;3805.46723458716;5172.629253247892;5301.469853014668;5302.469753024705;5366.785328586851;5390.78436862525;4818.000529780172;4819.975900120512;4847.709137451764;4875.731834749087;4878.438979517366;5623.409541998113;5695.430456954313;5696.316442026942;5698.857528561778;5748.626339287975;4060.1879624075304;4125.8968525786795;4157.147784704129;4162.979185104085;4171.478565179353;5767.567432442584;5883.264591925967;5927.970360148215;5939.2575928009;5951.720380118295;4116.897077573085;4137.358709400048;4155.361345545601;4156.521999970042;4158.334666453414;4183;4202.747835129902;4204.351258706995;4204.558521355275;4215.747055176699;4523.276275795857;4795.376601041842;4799.992001679617;4806.519348065165;4807.4471435785335;5694.857628559319;5706.885862282814;5715.657060576295;5716.170165988798;5735.254416925773;1437.1233547535994;1450.2524458028051;1456.1554298507053;1458.9197594132213;1463.2098666720065;869.5521806269776;921.7326975177258;924.5746956400131;945.6501094595044;953.9697127102712;4869.853904382874;4895.31465594817;4919.909038658556;4921.089598424303;4925.975370123127;5108.693478391308;5123.5644970177955;5126.052519801055;5156.432792392834;5167.560757335594;4649.4420669519195;4836;4864.39474973258;4894.608431325485;4908.754562271872;2727.2500062482977;2749.738774816389;2750.683671377817;2765.3777899972347;2775.001998561033;5266;5287.867803304871;5304.177852432879;5317.973410133002;5335.33308336458;4880.511948805091;5123.923141152885;5136.743162841843;5157.865269640673;5196.844094677166;5223.4776522347465;5231.3199284092825;5250.317458730341;5268.814516733704;5275.340582427273;5036.496350364934;5090.770915308746;5094.337736094284;5105.285260063668;5122.718250496258;4728.997086849807;5044.495550444926;5060.672090838256;5068.341115654941;5078.54658831983;5278.542554626726;5884.882302353843;6066.302375226729;6073.817785466443;6076.179715738495;4154.3976123462535;4208.569086510601;4223.282042052797;4232.195882782262;4241.957580424156;5685.857853553694;5802.912956305574;5859.267591551056;5946.432140715536;5957.255343082114;5714.771409143754;5734.197212390352;5741.196232527533;5754.625949313281;5768.451997060272;5740.655560666373;5752.741126649227;5757.827265181883;5759.65442073477;5770.413136387527;5491.336701699753;5652.576056795675;5673.858153546194;5705.172749951317;5716.456936591017;5765.221695071112;5768.279459748523;5779.797707080232;5785.913211301918;5789.305283366023;5618.438156184349;5624.915626265692;5634.6337488063145;5654.85862853432;5674.886502269849 04:50:50 INFO - PROCESS | 10133 | |5;yui.html;734.6363550042728;742.498813301022;780.0795061827042;800.7637746864674;828.7762304177872;14173.787393189097;14935.925320373382;15145.621359466006;15243.085414875115;15367.15480648564;14763.852361476382;15031.549053528412;15076.698466030673;15079.396824127049;15090.245487725624;785.4187900953282;796.2037962037962;807.588130053671;811.3874025111033;821.0434843407423;814.5275740070745;823.9052508961456;824.5918270456133;824.8680211166214;825.4923222218353;861.1775754154767;866.1165611076698;867.5792240763225;868.0928429790883;868.444195714743;852.5609311204735;859.2953777902122;859.3340161374953;860.3676297921023;860.8579584368572;620.8478922663932;623.3735096228307;626.029654036242;629.987400251997;630.2059405149545;14830.110193388431;14835.10989340643;14838.480653177086;14848;14878.776818347733;14087.859121408757;14374.92812535941;14760.261986900612;14778;15024.248787560578;11243.156763242709;11290.604828831034;11341.149413793999;11345.659630211025;12006.279623222634;3798.1074447504816;3859.5368555773207;3872.8257228424786;3889.5527014393424;3916.1971795781797;79539.20460795434;80691;81702;83280.58359708224;83830.58084709599;11255.718607034725;11371.147163962736;11379.260348077349;11490;11584.247023943586;21256.78743212579;21396.78603213948;21752.564948700936;21779.564408711736;21814.672779908313;8071.636776345079;8145.3302073076065;8164.183581641907;8223.506589604644;8454.87317690235;4405.669574781904;4531.524189960072;4561.156186105581;4578.587927086578;4603.9079218415445;3478.930421391558;3672.026912868092;3681.079730067483;3683.4474828775897;3691.7415780895617;582.7843697831829;606.5026678123896;618.935011823761;622.3776223776224;643.3823529411817;590.6338070396382;612.185792895448;671.8757029949475;674.6930146783202;676.5636164673758;9152.771180720536;9432.434053956647;9474.194693450996;9559.740894890725;9719.805603887882;622.5455417545218;694.1531331775226;703.711478293897;726.2700985509634;759.3621358059256;4363.258246098171;4679.243025505004;4706.270528068155;4736.194846876039;4763.428388593391;100681.49659251803;119967;123475.38262308811;123970;126706.36646816891;104898;106451;107029;108607.88097547427;111055;90157;91613;94464.80443575532;94803;97100.83340415801;8869.334799889904;8874.822503550022;8894.110588941054;8966.506842123747;8975.685850995184;51602;54141;54158.18762718641;54956.17565736597;55109.1733623988;74146.62926685548;80748.59625701833;81579.59210203911;81936;82189.58905205436;10011.198765647048;10133.847992280269;10381.377117372982;10650.360978341325;10741.785164296827;11397.658070257905;11586.884131158919;11996.340201289013;12381.380930953235;12492.812607811073;11154;11378.772424551627;11584.189106762446;11798.646040618794;12181.14731968789;11502.88497115018;11570.537178512765;12126.151169418055;12260.938695306466;12263.816042759187;11083.224174307721;11494.195406321478;11545.48045337945;11847.76304473923;11967.64097077089;9061.13919177677;9171.724848254564;9721.222302215947;10420.843687344848;10663.253572249869;8837.646494140163;9549.809003820024;10023.148032417326;10038.598456061967;10047.547860346156 04:50:50 INFO - PROCESS | 10133 | __end_tp_report 04:50:50 INFO - PROCESS | 10133 | __start_cc_report 04:50:50 INFO - PROCESS | 10133 | _x_x_mozilla_cycle_collect,302 04:50:50 INFO - PROCESS | 10133 | __end_cc_report 04:50:50 INFO - PROCESS | 10133 | __startTimestamp1475754650442__endTimestamp 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | ------- Summary: start ------- 04:50:50 INFO - PROCESS | 10133 | Number of tests: 6 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#0] dojo.html Cycles:165 Average:5270.32 Median:5508.83 stddev:589.18 (10.7%) stddev-sans-first:563.37 04:50:50 INFO - PROCESS | 10133 | Values: 2997.7 3019.0 3034.0 3041.8 3052.2 5106.2 5254.5 5348.5 5367.7 5367.7 5135.6 5225.2 5287.9 5296.3 5359.7 4757.1 4850.9 4868.3 4920.9 4958.5 4941.9 4952.3 4964.5 4968.7 4978.8 4699.4 4734.9 4755.7 4900.2 4949.9 4782.0 4802.2 4825.2 4862.6 4873.1 4728.4 4767.2 4791.5 4796.1 4824.7 5140.2 5178.7 5236.7 5248.7 5268.6 5608.2 5617.4 5620.2 5622.0 5623.6 5648.0 5656.2 5657.9 5658.2 5659.8 5235.0 5285.2 5292.6 5293.4 5294.9 5704.6 5735.6 5745.3 5748.7 5761.4 5576.6 5601.4 5602.1 5603.6 5608.6 5483.2 5663.4 5665.4 5665.7 5668.6 5510.6 5525.1 5530.3 5543.9 5574.6 5593.6 5612.8 5616.6 5621.6 5626.9 4305.2 4352.6 4373.3 4398.3 4407.3 3923.5 3926.0 3930.9 3975.6 3979.9 5485.4 5499.9 5510.3 5519.8 5559.0 5557.9 5593.0 5625.7 5787.7 5794.5 5331.8 5390.5 5402.1 5437.5 5456.0 4900.1 4906.9 4908.6 4928.8 4966.2 5724.2 5773.1 5854.3 5857.6 5866.1 5710.9 5722.7 5763.9 5780.6 5782.2 5781.4 5856.4 5921.2 5921.3 5922.0 5418.1 5573.2 5573.9 5605.2 5610.4 5567.1 5663.6 5739.3 5773.9 5779.9 5562.7 5566.9 5568.6 5573.2 5574.9 5381.0 5432.1 5502.1 5551.3 5558.9 5502.9 5508.8 5521.6 5563.9 5578.1 5568.2 5572.4 5610.2 5614.6 5628.2 5389.4 5435.5 5507.4 5508.0 5559.9 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#1] ext.html Cycles:180 Average:58052.60 Median:40673.30 stddev:115633.29 (284.3%) stddev-sans-first:115877.13 04:50:50 INFO - PROCESS | 10133 | Values: 567.0 568.8 574.5 584.7 586.3 41655.4 42709.0 42824.4 46678.0 46681.8 43893.6 44255.1 44613.3 44691.6 44979.6 8875.0 9020.1 9035.8 9036.2 9036.4 8861.5 8952.5 8961.1 8962.3 8970.8 8926.0 8973.3 9037.7 9043.1 9084.4 8867.1 8882.4 8884.7 8899.5 8931.7 8732.1 8799.3 8812.8 8813.1 8836.8 41408.4 41603.6 41658.4 41786.6 42015.8 3422.1 3459.1 3611.7 3752.6 4012.9 30638.0 31026.3 31107.4 31613.0 31670.2 4037.4 4057.2 4060.4 4092.2 4155.1 301160.0 301222.0 302057.0 303708.0 304546.0 54629.2 54787.7 55049.4 55074.2 55117.4 57607.4 57772.0 57793.0 57882.4 57997.4 16608.2 16658.8 16750.7 16869.3 16873.7 13071.5 13181.1 13235.6 13253.1 13264.7 14996.8 15540.0 15686.1 15713.8 15741.8 5644.7 5763.3 5838.1 5844.5 5905.9 894.8 1001.1 1020.8 1096.2 1127.9 30545.7 30653.2 31190.7 31653.7 31695.0 1062.9 1075.7 1086.0 1138.5 1193.0 15537.8 15948.7 16098.8 16138.7 16181.8 517519.0 525651.0 527668.0 530337.0 532774.0 53528.0 53955.0 54161.7 54249.7 54689.5 1295.7 1347.5 1362.7 1367.8 1391.5 28024.6 29437.3 29637.4 29655.3 30651.0 46503.1 46539.3 46554.5 46866.4 46961.8 445769.0 447055.0 447329.0 447784.0 448620.0 26657.6 26875.9 27069.2 27185.5 27222.3 42164.6 44715.3 46148.1 46279.0 46450.1 37708.6 38118.6 39154.6 40206.8 40698.8 38919.8 38934.4 39109.0 39697.2 40647.8 38910.2 40089.2 40340.8 40348.4 40407.4 33316.2 35514.0 35620.5 36012.5 36250.0 27410.5 27472.7 27805.0 27840.6 28008.7 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#2] jquery.html Cycles:180 Average:25336.10 Median:2233.99 stddev:65406.71 (2927.8%) stddev-sans-first:65563.37 04:50:50 INFO - PROCESS | 10133 | Values: 391.6 391.6 395.2 401.2 425.4 14727.4 18539.5 18923.0 19253.8 19396.0 18177.9 18296.9 18836.0 19290.1 19296.0 5528.1 5677.4 5794.7 5822.2 5875.9 5550.1 5821.2 5841.9 5856.2 5865.1 5850.7 5959.2 5962.9 5972.6 6006.2 5780.8 5855.4 5907.9 5964.4 5990.9 5711.6 5717.4 5717.5 5718.5 5721.3 13910.6 14075.6 14112.5 14287.2 18788.9 2265.5 2277.9 2320.6 2356.4 2820.0 9378.9 10025.8 10028.9 10398.2 10418.9 1856.6 1856.9 1895.9 1946.5 1958.4 71332.6 72027.3 72748.3 82810.0 86673.6 10866.6 10882.9 10894.8 11250.6 11346.6 12487.9 13279.2 15296.2 15337.9 15344.7 7811.8 7907.8 7926.7 8106.7 8249.1 7823.8 8002.8 8206.1 8240.5 8258.2 4006.7 4066.8 4101.4 4147.4 4223.1 1912.2 1921.5 1941.4 1958.7 2015.6 919.9 971.2 999.6 1000.3 1038.0 19156.1 19407.4 19585.9 19593.2 20053.4 457.2 463.9 470.8 475.0 487.3 6140.9 6279.8 6461.3 6518.3 6574.6 325630.0 329182.0 367231.0 442018.0 473825.0 86453.6 91991.5 93450.5 94419.0 95821.0 465.8 475.7 480.1 480.5 481.7 10822.2 11139.4 11167.9 11208.9 11353.9 36524.3 37773.0 40825.0 41319.8 41920.6 54701.5 56223.4 57216.7 57783.7 59088.4 8435.3 8626.5 8707.1 8812.5 8821.5 11743.4 12818.6 12818.7 13025.2 13148.2 10748.4 11034.2 11438.3 11508.3 11741.9 11407.5 11444.6 11523.5 11563.5 11584.5 11091.3 11628.0 11629.9 11644.7 11792.8 8054.5 8336.7 8525.3 8628.0 9121.0 11405.3 11458.5 11470.2 11703.9 11928.2 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#3] mootools.html Cycles:180 Average:5757.02 Median:466.54 stddev:3324.11 (712.5%) stddev-sans-first:3317.77 04:50:50 INFO - PROCESS | 10133 | Values: 1462.4 1489.8 1601.9 1734.1 1746.4 7796.2 8022.5 8293.3 9035.1 9139.2 8340.8 8573.0 8592.4 8865.6 8870.9 2279.1 2291.0 2295.2 2303.4 2303.6 2278.1 2281.3 2324.3 2331.5 2339.5 2285.3 2335.6 2337.7 2339.0 2352.8 2291.0 2295.5 2297.1 2308.4 2309.0 2253.8 2270.6 2273.1 2285.4 2286.4 8865.7 8953.9 8960.5 8970.7 8992.4 5131.6 5208.4 5273.0 5275.2 5277.6 3110.4 3183.1 3323.1 3361.6 3373.3 1091.4 1092.6 1121.8 1131.7 1158.6 12482.9 12483.4 12540.5 12559.4 12564.6 4336.6 4440.2 4548.4 4555.2 4619.7 10504.5 10511.2 10533.8 10535.7 10539.5 5228.7 5261.0 5262.8 5281.0 5283.9 4062.8 4194.8 4683.1 4836.1 4854.1 3719.9 3794.2 3809.8 3816.3 3931.6 1221.8 1232.5 1232.6 1236.0 1243.4 783.9 859.0 874.9 925.2 980.3 5619.0 5622.2 5682.2 5704.3 5860.6 460.0 464.4 468.6 473.9 474.9 4112.8 4127.4 4147.3 4160.1 4182.1 10579.9 10835.8 10931.6 10956.3 10976.5 10775.1 10791.1 10792.8 10805.8 10851.5 7781.3 8132.0 8135.7 8203.1 8225.1 6141.4 6179.3 6245.1 6245.3 6315.7 10161.8 10236.8 10250.3 10306.0 10313.8 9356.5 9742.2 9765.7 10016.9 10066.4 6984.8 7161.6 7389.6 7816.8 8033.2 8412.5 8794.5 8808.9 8810.8 8816.3 7486.8 7610.2 7619.9 7716.6 7749.9 7159.9 7387.5 7392.1 7587.6 7602.5 6830.7 6961.0 6968.9 6978.3 6997.7 5049.5 5212.5 5254.8 5438.5 5513.3 5240.1 5286.9 5313.6 5424.3 5442.6 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#4] prototype.html Cycles:180 Average:4633.25 Median:5106.99 stddev:1341.41 (26.3%) stddev-sans-first:1305.19 04:50:50 INFO - PROCESS | 10133 | Values: 302.3 316.3 323.7 325.9 329.2 4956.6 5192.4 5453.6 5467.8 5468.4 5288.9 5379.1 5429.6 5433.0 5448.6 4297.2 4298.3 4302.9 4318.5 4320.3 4108.8 4269.5 4285.7 4288.5 4306.9 4212.2 4218.8 4251.0 4252.3 4277.3 4246.5 4247.4 4249.8 4251.3 4264.9 3783.1 3785.8 3790.0 3790.8 3805.5 5172.6 5301.5 5302.5 5366.8 5390.8 4818.0 4820.0 4847.7 4875.7 4878.4 5623.4 5695.4 5696.3 5698.9 5748.6 4060.2 4125.9 4157.1 4163.0 4171.5 5767.6 5883.3 5928.0 5939.3 5951.7 4116.9 4137.4 4155.4 4156.5 4158.3 4183.0 4202.7 4204.4 4204.6 4215.7 4523.3 4795.4 4800.0 4806.5 4807.4 5694.9 5706.9 5715.7 5716.2 5735.3 1437.1 1450.3 1456.2 1458.9 1463.2 869.6 921.7 924.6 945.7 954.0 4869.9 4895.3 4919.9 4921.1 4926.0 5108.7 5123.6 5126.1 5156.4 5167.6 4649.4 4836.0 4864.4 4894.6 4908.8 2727.3 2749.7 2750.7 2765.4 2775.0 5266.0 5287.9 5304.2 5318.0 5335.3 4880.5 5123.9 5136.7 5157.9 5196.8 5223.5 5231.3 5250.3 5268.8 5275.3 5036.5 5090.8 5094.3 5105.3 5122.7 4729.0 5044.5 5060.7 5068.3 5078.5 5278.5 5884.9 6066.3 6073.8 6076.2 4154.4 4208.6 4223.3 4232.2 4242.0 5685.9 5802.9 5859.3 5946.4 5957.3 5714.8 5734.2 5741.2 5754.6 5768.5 5740.7 5752.7 5757.8 5759.7 5770.4 5491.3 5652.6 5673.9 5705.2 5716.5 5765.2 5768.3 5779.8 5785.9 5789.3 5618.4 5624.9 5634.6 5654.9 5674.9 04:50:50 INFO - PROCESS | 10133 | 04:50:50 INFO - PROCESS | 10133 | [#5] yui.html Cycles:180 Average:21306.46 Median:4641.58 stddev:32179.52 (693.3%) stddev-sans-first:32232.72 04:50:50 INFO - PROCESS | 10133 | Values: 734.6 742.5 780.1 800.8 828.8 14173.8 14935.9 15145.6 15243.1 15367.2 14763.9 15031.5 15076.7 15079.4 15090.2 785.4 796.2 807.6 811.4 821.0 814.5 823.9 824.6 824.9 825.5 861.2 866.1 867.6 868.1 868.4 852.6 859.3 859.3 860.4 860.9 620.8 623.4 626.0 630.0 630.2 14830.1 14835.1 14838.5 14848.0 14878.8 14087.9 14374.9 14760.3 14778.0 15024.2 11243.2 11290.6 11341.1 11345.7 12006.3 3798.1 3859.5 3872.8 3889.6 3916.2 79539.2 80691.0 81702.0 83280.6 83830.6 11255.7 11371.1 11379.3 11490.0 11584.2 21256.8 21396.8 21752.6 21779.6 21814.7 8071.6 8145.3 8164.2 8223.5 8454.9 4405.7 4531.5 4561.2 4578.6 4603.9 3478.9 3672.0 3681.1 3683.4 3691.7 582.8 606.5 618.9 622.4 643.4 590.6 612.2 671.9 674.7 676.6 9152.8 9432.4 9474.2 9559.7 9719.8 622.5 694.2 703.7 726.3 759.4 4363.3 4679.2 4706.3 4736.2 4763.4 100681.5 119967.0 123475.4 123970.0 126706.4 104898.0 106451.0 107029.0 108607.9 111055.0 90157.0 91613.0 94464.8 94803.0 97100.8 8869.3 8874.8 8894.1 8966.5 8975.7 51602.0 54141.0 54158.2 54956.2 55109.2 74146.6 80748.6 81579.6 81936.0 82189.6 10011.2 10133.8 10381.4 10650.4 10741.8 11397.7 11586.9 11996.3 12381.4 12492.8 11154.0 11378.8 11584.2 11798.6 12181.1 11502.9 11570.5 12126.2 12260.9 12263.8 11083.2 11494.2 11545.5 11847.8 11967.6 9061.1 9171.7 9721.2 10420.8 10663.3 8837.6 9549.8 10023.1 10038.6 10047.5 04:50:50 INFO - PROCESS | 10133 | -------- Summary: end -------- 04:50:50 INFO - PROCESS | 10133 | 04:50:51 INFO - TEST-INFO | 10133: exit 0 04:50:51 INFO - TEST-OK | dromaeo_css | took 1114942ms 04:50:51 INFO - TEST-START | kraken 04:50:51 INFO - operating with platform_type : linux_ 04:50:51 INFO - Initialising browser for kraken test... 04:50:51 INFO - TEST-INFO | started process 10485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJUXv4w/profile http://localhost:47896/getInfo.html) 04:50:55 INFO - PROCESS | 10485 | __metrics Screen width/height:1600/1200 04:50:55 INFO - PROCESS | 10485 | colorDepth:24 04:50:55 INFO - PROCESS | 10485 | Browser inner width/height: 1024/697 04:50:55 INFO - PROCESS | 10485 | __metrics 04:50:56 ERROR - PROCESS | 10485 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 04:50:57 INFO - TEST-INFO | 10485: exit 0 04:50:57 INFO - Browser initialized. 04:50:57 INFO - Running cycle 1/1 for kraken test... 04:50:57 INFO - TEST-INFO | started process 10610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJUXv4w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:09 INFO - PROCESS | 10610 | RSS: Main: 184999936 04:51:09 INFO - PROCESS | 10610 | 04:51:12 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47896/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:13 INFO - PROCESS | 10610 | RSS: Main: 198463488 04:51:13 INFO - PROCESS | 10610 | 04:51:15 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47896/tests/kraken/driver.html?testName=audio-dft) 04:51:16 INFO - PROCESS | 10610 | RSS: Main: 197050368 04:51:16 INFO - PROCESS | 10610 | 04:51:19 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47896/tests/kraken/driver.html?testName=audio-fft) 04:51:19 INFO - PROCESS | 10610 | RSS: Main: 192565248 04:51:19 INFO - PROCESS | 10610 | 04:51:21 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47896/tests/kraken/driver.html?testName=audio-oscillator) 04:51:22 INFO - PROCESS | 10610 | RSS: Main: 193015808 04:51:22 INFO - PROCESS | 10610 | 04:51:24 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:25 INFO - PROCESS | 10610 | RSS: Main: 193122304 04:51:25 INFO - PROCESS | 10610 | 04:51:28 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47896/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:29 INFO - PROCESS | 10610 | RSS: Main: 193466368 04:51:29 INFO - PROCESS | 10610 | 04:51:32 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47896/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:33 INFO - PROCESS | 10610 | RSS: Main: 193601536 04:51:33 INFO - PROCESS | 10610 | 04:51:36 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47896/tests/kraken/driver.html?testName=json-parse-financial) 04:51:36 INFO - PROCESS | 10610 | RSS: Main: 193761280 04:51:36 INFO - PROCESS | 10610 | 04:51:38 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:38 INFO - PROCESS | 10610 | RSS: Main: 193626112 04:51:38 INFO - PROCESS | 10610 | 04:51:40 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:41 INFO - PROCESS | 10610 | RSS: Main: 193519616 04:51:41 INFO - PROCESS | 10610 | 04:51:43 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:43 INFO - PROCESS | 10610 | RSS: Main: 194244608 04:51:43 INFO - PROCESS | 10610 | 04:51:46 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:47 INFO - PROCESS | 10610 | RSS: Main: 194060288 04:51:47 INFO - PROCESS | 10610 | 04:51:50 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:50 INFO - PROCESS | 10610 | RSS: Main: 194285568 04:51:50 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | Cycle 1(1): loaded http://localhost:47896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47896/tests/kraken/driver.html?testName=ai-astar) 04:51:52 INFO - PROCESS | 10610 | RSS: Main: 195739648 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | __start_tp_report 04:51:52 INFO - PROCESS | 10610 | _x_x_mozilla_page_load 04:51:52 INFO - PROCESS | 10610 | _x_x_mozilla_page_load_details 04:51:52 INFO - PROCESS | 10610 | |i|pagename|runs| 04:51:52 INFO - PROCESS | 10610 | |0;ai-astar;106;114;113;115;115;114;114;115;115;113 04:51:52 INFO - PROCESS | 10610 | |1;audio-beat-detection;156;126;137;173;126;126;136;133;158;128 04:51:52 INFO - PROCESS | 10610 | |2;audio-dft;163;164;166;166;166;163;163;163;162;164 04:51:52 INFO - PROCESS | 10610 | |3;audio-fft;85;75;76;114;77;78;77;76;100;76 04:51:52 INFO - PROCESS | 10610 | |4;audio-oscillator;83;83;111;83;83;84;99;83;83;113 04:51:52 INFO - PROCESS | 10610 | |5;imaging-gaussian-blur;118;119;117;117;117;118;117;118;117;119 04:51:52 INFO - PROCESS | 10610 | |6;imaging-darkroom;146;147;147;147;147;147;147;148;147;154 04:51:52 INFO - PROCESS | 10610 | |7;imaging-desaturate;97;97;96;95;95;95;96;96;96;96 04:51:52 INFO - PROCESS | 10610 | |8;json-parse-financial;52;52;55;52;53;53;54;54;53;56 04:51:52 INFO - PROCESS | 10610 | |9;json-stringify-tinderbox;59;59;59;59;60;59;60;59;59;60 04:51:52 INFO - PROCESS | 10610 | |10;stanford-crypto-aes;80;86;81;80;86;81;88;80;80;80 04:51:52 INFO - PROCESS | 10610 | |11;stanford-crypto-ccm;151;139;140;142;134;150;139;135;192;131 04:51:52 INFO - PROCESS | 10610 | |12;stanford-crypto-pbkdf2;173;166;164;165;171;168;172;169;168;171 04:51:52 INFO - PROCESS | 10610 | |13;stanford-crypto-sha256-iterative;66;67;68;66;68;65;67;69;68;66 04:51:52 INFO - PROCESS | 10610 | __end_tp_report 04:51:52 INFO - PROCESS | 10610 | __start_cc_report 04:51:52 INFO - PROCESS | 10610 | _x_x_mozilla_cycle_collect,781 04:51:52 INFO - PROCESS | 10610 | __end_cc_report 04:51:52 INFO - PROCESS | 10610 | __startTimestamp1475754712820__endTimestamp 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | ------- Summary: start ------- 04:51:52 INFO - PROCESS | 10610 | Number of tests: 14 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:2.72 (2.4%) stddev-sans-first:0.83 04:51:52 INFO - PROCESS | 10610 | Values: 106.0 114.0 113.0 115.0 115.0 114.0 114.0 115.0 115.0 113.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:136.50 stddev:16.58 (12.1%) stddev-sans-first:16.53 04:51:52 INFO - PROCESS | 10610 | Values: 156.0 126.0 137.0 173.0 126.0 126.0 136.0 133.0 158.0 128.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.49 (0.9%) stddev-sans-first:1.54 04:51:52 INFO - PROCESS | 10610 | Values: 163.0 164.0 166.0 166.0 166.0 163.0 163.0 163.0 162.0 164.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:13.17 (17.2%) stddev-sans-first:13.95 04:51:52 INFO - PROCESS | 10610 | Values: 85.0 75.0 76.0 114.0 77.0 78.0 77.0 76.0 100.0 76.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.38 (14.9%) stddev-sans-first:12.83 04:51:52 INFO - PROCESS | 10610 | Values: 83.0 83.0 111.0 83.0 83.0 84.0 99.0 83.0 83.0 113.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:51:52 INFO - PROCESS | 10610 | Values: 118.0 119.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 119.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:2.26 (1.5%) stddev-sans-first:2.32 04:51:52 INFO - PROCESS | 10610 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 154.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 04:51:52 INFO - PROCESS | 10610 | Values: 97.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.35 (2.5%) stddev-sans-first:1.33 04:51:52 INFO - PROCESS | 10610 | Values: 52.0 52.0 55.0 52.0 53.0 53.0 54.0 54.0 53.0 56.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:51:52 INFO - PROCESS | 10610 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 59.0 59.0 60.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.00 stddev:3.16 (3.9%) stddev-sans-first:3.24 04:51:52 INFO - PROCESS | 10610 | Values: 80.0 86.0 81.0 80.0 86.0 81.0 88.0 80.0 80.0 80.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.00 stddev:17.61 (12.5%) stddev-sans-first:18.56 04:51:52 INFO - PROCESS | 10610 | Values: 151.0 139.0 140.0 142.0 134.0 150.0 139.0 135.0 192.0 131.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:170.00 stddev:3.06 (1.8%) stddev-sans-first:2.82 04:51:52 INFO - PROCESS | 10610 | Values: 173.0 166.0 164.0 165.0 171.0 168.0 172.0 169.0 168.0 171.0 04:51:52 INFO - PROCESS | 10610 | 04:51:52 INFO - PROCESS | 10610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 04:51:52 INFO - PROCESS | 10610 | Values: 66.0 67.0 68.0 66.0 68.0 65.0 67.0 69.0 68.0 66.0 04:51:52 INFO - PROCESS | 10610 | -------- Summary: end -------- 04:51:52 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - PROCESS | 10610 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 04:51:53 INFO - PROCESS | 10610 | 04:51:53 INFO - TEST-INFO | 10610: exit 0 04:51:53 INFO - TEST-OK | kraken | took 62602ms 04:51:53 INFO - SUITE-END | took 1177s 04:51:53 INFO - Completed test suite (00:19:37) 04:51:53 INFO - javascript benchmark 04:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7008.9104956177125, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2997.7002299770024, 3018.973548993342, 3034.0291106845802, 3041.8326992015445, 3052.236940764809, 5106.234064890259, 5254.500822421868, 5348.5453736432355, 5367.70477623731, 5367.731613419328, 5135.563477104451, 5225.163973764198, 5287.920681189786, 5296.285001524793, 5359.678419294835, 4757.096151731177, 4850.87872803181, 4868.318435419044, 4920.852374428773, 4958.504149585049, 4941.851744447655, 4952.281919121725, 4964.453910069889, 4968.726720030397, 4978.825741099062, 4699.389079419688, 4734.928976065362, 4755.714657120584, 4900.240462728283, 4949.876253093666, 4781.952180478185, 4802.159622066124, 4825.227963525854, 4862.5623693867365, 4873.122837889178, 4728.361671174382, 4767.189577771787, 4791.520847915215, 4796.136695394827, 4824.6863953842885, 5140.1518749406305, 5178.689278643255, 5236.659617124913, 5248.71132087735, 5268.631195816294, 5608.158776183564, 5617.410171931929, 5620.185073164409, 5621.971890140523, 5623.550115990711, 5648.039833228361, 5656.151577263443, 5657.9434205658235, 5658.151277308396, 5659.773609055633, 5235.0, 5285.233641122054, 5292.629515933848, 5293.41772405039, 5294.947050529484, 5704.600677952503, 5735.598508104393, 5745.2818397700285, 5748.6838223898085, 5761.3950535194035, 5576.581756368289, 5601.355844077902, 5602.075657516546, 5603.635763675348, 5608.551315894719, 5483.204935284361, 5663.377028526858, 5665.405132461115, 5665.716714164275, 5668.57485688575, 5510.641808282448, 5525.060739674265, 5530.308711411074, 5543.944560554342, 5574.554035677136, 5593.636413633182, 5612.831615051555, 5616.550675945915, 5621.634593751393, 5626.85932851682, 4305.160493703697, 4352.586504282088, 4373.322135069069, 4398.318260669601, 4407.294832826797, 3923.4899463070187, 3926.0, 3930.862419815293, 3975.602439756059, 3979.9403008954887, 5485.402717236656, 5499.917501237484, 5510.311211098613, 5519.806806761744, 5559.0, 5557.944420555743, 5593.0, 5625.746841392147, 5787.652740835563, 5794.478496935296, 5331.840044798585, 5390.54180394663, 5402.135658294733, 5437.45625437461, 5456.045192091368, 4900.068986892479, 4906.90186196274, 4908.558229759339, 4928.802847886116, 4966.230234313687, 5724.198612194379, 5773.134029895549, 5854.268216473026, 5857.619254748428, 5866.12008198765, 5710.942890571041, 5722.6852523109965, 5763.94236057634, 5780.624259423124, 5782.190493330853, 5781.4218578141845, 5856.443637854397, 5921.230240068763, 5921.289445266596, 5921.970390148022, 5418.051840927901, 5573.247611572548, 5573.944260557342, 5605.243292155506, 5610.354809196994, 5567.081431563746, 5663.631863928831, 5739.253896993364, 5773.942260577341, 5779.913301300568, 5562.694051827189, 5566.888662226652, 5568.638038527482, 5573.219749235192, 5574.9442505574425, 5380.973095134499, 5432.130859062531, 5502.147167189092, 5551.333839939233, 5558.916616250679, 5502.944970550243, 5508.834734957958, 5521.558275338044, 5563.8887222256135, 5578.135389014709, 5568.248286481273, 5572.414896435978, 5610.242617246783, 5614.578906581941, 5628.183913332462, 5389.434109418611, 5435.456454354533, 5507.449255074461, 5508.0, 5559.8888022240135], "value": 5230.76538260725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.0218872445033, 568.8151350810986, 574.5374973146616, 584.6608966799257, 586.331581996524, 41655.37516937245, 42709.0, 42824.357634635424, 46678.0, 46681.766591167, 43893.561064389345, 44255.11489770203, 44613.33080003803, 44691.553084469146, 44979.550204498024, 8874.955625221864, 9020.052894446088, 9035.774105647346, 9036.186743193111, 9036.367454278203, 8861.468311901306, 8952.462852228855, 8961.148690874388, 8962.283017358595, 8970.775730606754, 8925.95537022314, 8973.282137429023, 9037.728868133967, 9043.050479699636, 9084.364094513387, 8867.113288671146, 8882.422642528247, 8884.689035883777, 8899.510526921016, 8931.687390941352, 8732.12678732128, 8799.29605631548, 8812.779680507974, 8813.07462716412, 8836.823263534758, 41408.378874316906, 41603.58396416058, 41658.37512437316, 41786.582134178876, 42015.789921050506, 3422.1273575238406, 3459.135216195951, 3611.693006094485, 3752.5684546277253, 4012.941111958575, 30638.0, 31026.328862394435, 31107.377852442823, 31613.0, 31670.208244793834, 4037.4347591337237, 4057.1885622875543, 4060.3909413587903, 4092.2224777292518, 4155.148194620096, 301160.0, 301222.0, 302057.0, 303708.0, 304546.0, 54629.1805622916, 54787.72606136944, 55049.44950550523, 55074.17388739172, 55117.44882551203, 57607.423925761046, 57772.0, 57793.0, 57882.42117578854, 57997.42002580005, 16608.169591520375, 16658.83341166597, 16750.74873876893, 16869.325226990783, 16873.662526749395, 13071.477140914258, 13181.077324587186, 13235.602931912059, 13253.072284940154, 13264.73470530584, 14996.775048374284, 15540.0, 15686.137262450446, 15713.764293535605, 15741.763873541906, 5644.689542075143, 5763.308402991668, 5838.1242813577455, 5844.47399734026, 5905.940940590539, 894.7518212094092, 1001.1090129784498, 1020.7703266764919, 1096.2435919215716, 1127.875933647298, 30545.69454305473, 30653.233669158002, 31190.68809311923, 31653.683463165533, 31695.0, 1062.9362238265574, 1075.6719200643722, 1085.978280434387, 1138.5218208352512, 1192.9582464613698, 15537.844621553866, 15948.681026379407, 16098.839011609969, 16138.67722645564, 16181.786366022596, 517519.0, 525651.0, 527668.0, 530337.0, 532774.0, 53528.0, 53955.0, 54161.72919135379, 54249.72875135599, 54689.453105468434, 1295.747329270802, 1347.5148946379295, 1362.7206422683525, 1367.8221831161886, 1391.5199256256576, 28024.579631305955, 29437.26406839846, 29637.407251855275, 29655.25861853471, 30651.0, 46503.069938601715, 46539.30191047069, 46554.53445465637, 46866.35967741113, 46961.76519117383, 445769.0, 447055.0, 447329.0, 447784.0, 448620.0, 26657.600135998364, 26875.893580219697, 27069.1879243623, 27185.456290873677, 27222.319442013315, 42164.578354217294, 44715.32927006033, 46148.07703845971, 46279.0, 46450.070998580515, 37708.62291377051, 38118.61881381151, 39154.6084539151, 40206.798966004986, 40698.79650601728, 38919.805400972815, 38934.415983759696, 39109.0, 39697.206055878145, 40647.796761016005, 38910.221795564496, 40089.198216034936, 40340.79829600833, 40348.394774077824, 40407.39388909227, 33316.16709582183, 35514.0, 35620.46569301411, 36012.45981310335, 36250.0, 27410.451790964467, 27472.725272747015, 27805.0, 27840.60178730012, 28008.71991280061], "value": 19421.154224540347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5986114232911, 391.6025234387097, 395.1839451532583, 401.2196278238825, 425.3555862867756, 14727.410903563845, 18539.536511587216, 18923.0, 19253.84476931385, 19396.0, 18177.909110454428, 18296.90851545744, 18836.0, 19290.131944062516, 19296.0, 5528.115501519757, 5677.37548869624, 5794.68129252891, 5822.184894114827, 5875.88248235035, 5550.111982082867, 5821.18503409523, 5841.912371314434, 5856.238688970428, 5865.120231965197, 5850.6782126983, 5959.225300710901, 5962.940370596282, 5972.611780234271, 6006.159137720722, 5780.82657520273, 5855.385184555603, 5907.940920590825, 5964.433378829026, 5990.8502287442725, 5711.600187986843, 5717.370549393445, 5717.514011309044, 5718.456746609066, 5721.342045664718, 13910.58268251954, 14075.648108797259, 14112.506062287874, 14287.214203218819, 18788.872667639986, 2265.4676151104477, 2277.908883644652, 2320.6170981787986, 2356.422676444282, 2820.0, 9378.85931711025, 10025.799484010278, 10028.94985525075, 10398.168146548258, 10418.895811041868, 1856.5915498590423, 1856.941543320308, 1895.9052047397574, 1946.464722201406, 1958.412476257117, 71332.6433367835, 72027.27972720258, 72748.27251727521, 82810.0, 86673.56663216707, 10866.565337386415, 10882.891171088346, 10894.805499882445, 11250.606228781953, 11346.602868899548, 12487.875121248853, 13279.203247805162, 15296.235188240544, 15337.932413517117, 15344.693106137815, 7811.804704882424, 7907.802304942307, 7926.682932682744, 8106.675732970733, 8249.092599814016, 7823.765287041398, 8002.79993000168, 8206.097329293772, 8240.464369815943, 8258.215469530385, 4006.659433948147, 4066.755994640331, 4101.405296232089, 4147.3778933159665, 4223.113146239262, 1912.235105957628, 1921.5196200949763, 1941.417574727576, 1958.676818324989, 2015.5968806238811, 919.935604507678, 971.2084651009404, 999.6301368493704, 1000.309786247487, 1038.0190719769896, 19156.137973791214, 19407.417777466697, 19585.902070489556, 19593.216271349273, 20053.39839804808, 457.17708125374196, 463.9420072490939, 470.7881453346008, 474.98575042748774, 487.3080226078976, 6140.8771824563255, 6279.780207692709, 6461.289258181596, 6518.28298887122, 6574.57265277765, 325630.0, 329182.0, 367231.0, 442018.0, 473825.0, 86453.56773216094, 91991.54004229936, 93450.53274733583, 94419.0, 95821.0, 465.77875509133565, 475.6575265808612, 480.0686667864332, 480.5050797678327, 481.696531185351, 10822.205208260919, 11139.387333696724, 11167.944160279147, 11208.943955280172, 11353.943230283796, 36524.26951461009, 37773.0, 40825.0, 41319.7934010328, 41920.580794191665, 54701.45298546964, 56223.43776562182, 57216.71391643015, 57783.71108144432, 59088.40911590829, 8435.283000944988, 8626.525541095049, 8707.129287071242, 8812.545929921747, 8821.470711757058, 11743.354115523387, 12818.55135070268, 12818.74362512726, 13025.153365031243, 13148.211107333591, 10748.408837514013, 11034.17243706709, 11438.256513326607, 11508.251963622337, 11741.941290293495, 11407.543698251977, 11444.599439019594, 11523.481443335239, 11563.537458501902, 11584.451420687436, 11091.33451992883, 11628.0, 11629.88370116288, 11644.6506604802, 11792.823107653563, 8054.516728996279, 8336.666533338599, 8525.275351594935, 8628.0, 9121.0, 11405.315681058832, 11458.541658333574, 11470.247140686008, 11703.882961170279, 11928.165028447926], "value": 8370.377025267135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.3638717158033, 1489.806325177727, 1601.8638415734663, 1734.1329335332334, 1746.4324094669228, 7796.1814009529035, 8022.478538894982, 8293.295069919057, 9035.051319611444, 9139.177474027345, 8340.791480212998, 8572.95713521433, 8592.398532102756, 8865.645374185026, 8870.86693699595, 2279.1453205048147, 2291.0, 2295.1966811615966, 2303.401115709919, 2303.6314189729646, 2278.100150440575, 2281.3384118605586, 2324.2794733632545, 2331.4521087544413, 2339.4502291961376, 2285.3486756274465, 2335.5912715274844, 2337.7194736631627, 2338.976610233893, 2352.788249057593, 2290.977090229093, 2295.494991101955, 2297.0811675329833, 2308.4459729664845, 2308.953820923589, 2253.774622537733, 2270.579942710604, 2273.102124660766, 2285.371522831218, 2286.416963674269, 8865.734027979106, 8953.865692014626, 8960.507172105532, 8970.686025989058, 8992.415492993, 5131.589472842164, 5208.427073021964, 5272.973635131838, 5275.182346736224, 5277.577793776489, 3110.3623757129963, 3183.108729555705, 3323.102762254202, 3361.596608407007, 3373.325334933023, 1091.399730148423, 1092.595739576354, 1121.7588218533056, 1131.7396998690265, 1158.5539567266578, 12482.937585312015, 12483.438245278985, 12540.498380064786, 12559.434825432878, 12564.560240391635, 4336.588024137765, 4440.245158323093, 4548.431446069241, 4555.157295900269, 4619.676622636383, 10504.527296271686, 10511.211659125596, 10533.789324213472, 10535.736606584744, 10539.524466574685, 5228.738563071907, 5261.026710058652, 5262.815801446931, 5280.970210808932, 5283.867903302371, 4062.8374865005067, 4194.769287689145, 4683.086798074411, 4836.105320515716, 4854.077725232195, 3719.8512059517316, 3794.2411517696573, 3809.8285577149095, 3816.2749077675153, 3931.6068393160454, 1221.7617564574823, 1232.4761976160096, 1232.5932442294022, 1236.0358920042381, 1243.384524660299, 783.902012248469, 858.9828203435897, 874.8906386701663, 925.2459245714721, 980.2501086668705, 5619.0, 5622.156676498558, 5682.176084467729, 5704.344000440003, 5860.619059761102, 459.9701019433726, 464.4496271917788, 468.6368064749846, 473.862579851846, 474.87178461815114, 4112.753234805921, 4127.442795222667, 4147.274227010261, 4160.1471698301775, 4182.142660754538, 10579.894201058045, 10835.78328433427, 10931.56273749057, 10956.28784129029, 10976.506057227443, 10775.084117849914, 10791.136709063256, 10792.838107428395, 10805.83791243132, 10851.457427128613, 7781.338586220121, 8131.9593402032615, 8135.6745730171315, 8203.097659257477, 8225.054118776417, 6141.385861413823, 6179.28938172098, 6245.094461303176, 6245.313015568375, 6315.715792789428, 10161.84757228657, 10236.846447303147, 10250.333728307636, 10306.0, 10313.793724125626, 9356.532173391439, 9742.220622350053, 9765.707028789147, 10016.899831001596, 10066.396016239049, 6984.825379365557, 7161.641917904188, 7389.556626602421, 7816.84366312682, 8033.236842499953, 8412.495250285003, 8794.472331660121, 8808.86786698213, 8810.779730506789, 8816.338774592059, 7486.812829679302, 7610.200928902607, 7619.885701714589, 7716.575588342471, 7749.883751743616, 7159.892601610876, 7387.482876198829, 7392.149902761036, 7587.58268295249, 7602.50583712057, 6830.692618832065, 6960.965195173992, 6968.860622787617, 6978.302169782981, 6997.685104170427, 5049.495050494921, 5212.452692467236, 5254.842354729364, 5438.510534051954, 5513.3108361454815, 5240.08298547745, 5286.920696189637, 5313.601479888946, 5424.267723857229, 5442.619016668795], "value": 4514.072344321888, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.25192648195707, 316.33096001955863, 323.705428060465, 325.86639477814094, 329.18855022369854, 4956.553910148086, 5192.443176424143, 5453.64551304165, 5467.835964921053, 5468.425815289392, 5288.867778305535, 5379.139337705968, 5429.619926605139, 5433.011843486087, 5448.618596698223, 4297.162053399588, 4298.290782020963, 4302.935455968163, 4318.546552611978, 4320.25663703549, 4108.77401742904, 4269.487661480626, 4285.700000999931, 4288.52826189119, 4306.858682449138, 4212.1996820604145, 4218.806220765216, 4250.979764856427, 4252.255855225339, 4277.272863613178, 4246.490421149451, 4247.362895565659, 4249.830006799724, 4251.277282861905, 4264.850730224427, 3783.127351960797, 3785.772853628791, 3789.995651152447, 3790.8104594770152, 3805.46723458716, 5172.629253247892, 5301.469853014668, 5302.469753024705, 5366.785328586851, 5390.78436862525, 4818.000529780172, 4819.975900120512, 4847.709137451764, 4875.731834749087, 4878.438979517366, 5623.409541998113, 5695.430456954313, 5696.316442026942, 5698.857528561778, 5748.626339287975, 4060.1879624075304, 4125.8968525786795, 4157.147784704129, 4162.979185104085, 4171.478565179353, 5767.567432442584, 5883.264591925967, 5927.970360148215, 5939.2575928009, 5951.720380118295, 4116.897077573085, 4137.358709400048, 4155.361345545601, 4156.521999970042, 4158.334666453414, 4183.0, 4202.747835129902, 4204.351258706995, 4204.558521355275, 4215.747055176699, 4523.276275795857, 4795.376601041842, 4799.992001679617, 4806.519348065165, 4807.4471435785335, 5694.857628559319, 5706.885862282814, 5715.657060576295, 5716.170165988798, 5735.254416925773, 1437.1233547535994, 1450.2524458028051, 1456.1554298507053, 1458.9197594132213, 1463.2098666720065, 869.5521806269776, 921.7326975177258, 924.5746956400131, 945.6501094595044, 953.9697127102712, 4869.853904382874, 4895.31465594817, 4919.909038658556, 4921.089598424303, 4925.975370123127, 5108.693478391308, 5123.5644970177955, 5126.052519801055, 5156.432792392834, 5167.560757335594, 4649.4420669519195, 4836.0, 4864.39474973258, 4894.608431325485, 4908.754562271872, 2727.2500062482977, 2749.738774816389, 2750.683671377817, 2765.3777899972347, 2775.001998561033, 5266.0, 5287.867803304871, 5304.177852432879, 5317.973410133002, 5335.33308336458, 4880.511948805091, 5123.923141152885, 5136.743162841843, 5157.865269640673, 5196.844094677166, 5223.4776522347465, 5231.3199284092825, 5250.317458730341, 5268.814516733704, 5275.340582427273, 5036.496350364934, 5090.770915308746, 5094.337736094284, 5105.285260063668, 5122.718250496258, 4728.997086849807, 5044.495550444926, 5060.672090838256, 5068.341115654941, 5078.54658831983, 5278.542554626726, 5884.882302353843, 6066.302375226729, 6073.817785466443, 6076.179715738495, 4154.3976123462535, 4208.569086510601, 4223.282042052797, 4232.195882782262, 4241.957580424156, 5685.857853553694, 5802.912956305574, 5859.267591551056, 5946.432140715536, 5957.255343082114, 5714.771409143754, 5734.197212390352, 5741.196232527533, 5754.625949313281, 5768.451997060272, 5740.655560666373, 5752.741126649227, 5757.827265181883, 5759.65442073477, 5770.413136387527, 5491.336701699753, 5652.576056795675, 5673.858153546194, 5705.172749951317, 5716.456936591017, 5765.221695071112, 5768.279459748523, 5779.797707080232, 5785.913211301918, 5789.305283366023, 5618.438156184349, 5624.915626265692, 5634.6337488063145, 5654.85862853432, 5674.886502269849], "value": 4201.572410397327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6363550042728, 742.498813301022, 780.0795061827042, 800.7637746864674, 828.7762304177872, 14173.787393189097, 14935.925320373382, 15145.621359466006, 15243.085414875115, 15367.15480648564, 14763.852361476382, 15031.549053528412, 15076.698466030673, 15079.396824127049, 15090.245487725624, 785.4187900953282, 796.2037962037962, 807.588130053671, 811.3874025111033, 821.0434843407423, 814.5275740070745, 823.9052508961456, 824.5918270456133, 824.8680211166214, 825.4923222218353, 861.1775754154767, 866.1165611076698, 867.5792240763225, 868.0928429790883, 868.444195714743, 852.5609311204735, 859.2953777902122, 859.3340161374953, 860.3676297921023, 860.8579584368572, 620.8478922663932, 623.3735096228307, 626.029654036242, 629.987400251997, 630.2059405149545, 14830.110193388431, 14835.10989340643, 14838.480653177086, 14848.0, 14878.776818347733, 14087.859121408757, 14374.92812535941, 14760.261986900612, 14778.0, 15024.248787560578, 11243.156763242709, 11290.604828831034, 11341.149413793999, 11345.659630211025, 12006.279623222634, 3798.1074447504816, 3859.5368555773207, 3872.8257228424786, 3889.5527014393424, 3916.1971795781797, 79539.20460795434, 80691.0, 81702.0, 83280.58359708224, 83830.58084709599, 11255.718607034725, 11371.147163962736, 11379.260348077349, 11490.0, 11584.247023943586, 21256.78743212579, 21396.78603213948, 21752.564948700936, 21779.564408711736, 21814.672779908313, 8071.636776345079, 8145.3302073076065, 8164.183581641907, 8223.506589604644, 8454.87317690235, 4405.669574781904, 4531.524189960072, 4561.156186105581, 4578.587927086578, 4603.9079218415445, 3478.930421391558, 3672.026912868092, 3681.079730067483, 3683.4474828775897, 3691.7415780895617, 582.7843697831829, 606.5026678123896, 618.935011823761, 622.3776223776224, 643.3823529411817, 590.6338070396382, 612.185792895448, 671.8757029949475, 674.6930146783202, 676.5636164673758, 9152.771180720536, 9432.434053956647, 9474.194693450996, 9559.740894890725, 9719.805603887882, 622.5455417545218, 694.1531331775226, 703.711478293897, 726.2700985509634, 759.3621358059256, 4363.258246098171, 4679.243025505004, 4706.270528068155, 4736.194846876039, 4763.428388593391, 100681.49659251803, 119967.0, 123475.38262308811, 123970.0, 126706.36646816891, 104898.0, 106451.0, 107029.0, 108607.88097547427, 111055.0, 90157.0, 91613.0, 94464.80443575532, 94803.0, 97100.83340415801, 8869.334799889904, 8874.822503550022, 8894.110588941054, 8966.506842123747, 8975.685850995184, 51602.0, 54141.0, 54158.18762718641, 54956.17565736597, 55109.1733623988, 74146.62926685548, 80748.59625701833, 81579.59210203911, 81936.0, 82189.58905205436, 10011.198765647048, 10133.847992280269, 10381.377117372982, 10650.360978341325, 10741.785164296827, 11397.658070257905, 11586.884131158919, 11996.340201289013, 12381.380930953235, 12492.812607811073, 11154.0, 11378.772424551627, 11584.189106762446, 11798.646040618794, 12181.14731968789, 11502.88497115018, 11570.537178512765, 12126.151169418055, 12260.938695306466, 12263.816042759187, 11083.224174307721, 11494.195406321478, 11545.48045337945, 11847.76304473923, 11967.64097077089, 9061.13919177677, 9171.724848254564, 9721.222302215947, 10420.843687344848, 10663.253572249869, 8837.646494140163, 9549.809003820024, 10023.148032417326, 10038.598456061967, 10047.547860346156], "value": 7350.10046780735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 137.0, 173.0, 126.0, 126.0, 136.0, 133.0, 158.0, 128.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 166.0, 166.0, 163.0, 163.0, 163.0, 162.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 76.0, 114.0, 77.0, 78.0, 77.0, 76.0, 100.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 83.0, 83.0, 84.0, 99.0, 83.0, 83.0, 113.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 154.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 52.0, 53.0, 53.0, 54.0, 54.0, 53.0, 56.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 81.0, 80.0, 86.0, 81.0, 88.0, 80.0, 80.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 139.0, 140.0, 142.0, 134.0, 150.0, 139.0, 135.0, 192.0, 131.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 164.0, 165.0, 171.0, 168.0, 172.0, 169.0, 168.0, 171.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 68.0, 65.0, 67.0, 69.0, 68.0, 66.0], "value": 67.0, "unit": "score"}]}]} 04:51:54 INFO - Return code: 0 04:51:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:54 ERROR - # TBPL SUCCESS # 04:51:54 INFO - Running post-action listener: _resource_record_post_action 04:51:54 INFO - [mozharness: 2016-10-06 11:51:54.158572Z] Finished run-tests step (success) 04:51:54 INFO - Running post-run listener: _resource_record_post_run 04:51:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 396926976; Read time: 0; Write time: 320004 04:51:54 INFO - TinderboxPrint: CPU usage
13.4% 04:51:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:51:54 INFO - TinderboxPrint: I/O write bytes / time
396,926,976 / 320,004 04:51:54 INFO - TinderboxPrint: CPU idle
8,246.1 (86.5%) 04:51:54 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 04:51:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107601920; Read time: 0; Write time: 97432 04:51:54 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289325056; Read time: 0; Write time: 222572 04:51:54 INFO - Running post-run listener: _upload_blobber_files 04:51:54 INFO - Blob upload gear active. 04:51:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:54 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 04:51:54 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'] 04:51:54 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 04:51:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:56 INFO - (blobuploader) - INFO - Done attempting. 04:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:00 INFO - (blobuploader) - INFO - Done attempting. 04:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:00 INFO - (blobuploader) - INFO - Done attempting. 04:52:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:00 INFO - Return code: 0 04:52:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04f641a80e244a8ac1f0d6febbc81c71e0c18cefcdcae124737188e9c0a62d95d8f1c79a1fb46cdf577337f991af859d64956b9bdad655d98e74b77808a47b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2f69f2721bd29a4a943f10469d5a640dda549dcbe4d4328d951952dd06dc48420cae2056f5aadbaca23dafc88e828316157bf6bcb172aeec8aeecfe13ebc75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2242aa63f4217b1e241e82fb94aa422864672464bdf60b92d2118be97fd13787d53858943d9ea3c1a2906f6b7cb6306290a8d530ef6312073215f4a33e38af64"} 04:52:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:00 INFO - Contents: 04:52:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04f641a80e244a8ac1f0d6febbc81c71e0c18cefcdcae124737188e9c0a62d95d8f1c79a1fb46cdf577337f991af859d64956b9bdad655d98e74b77808a47b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2f69f2721bd29a4a943f10469d5a640dda549dcbe4d4328d951952dd06dc48420cae2056f5aadbaca23dafc88e828316157bf6bcb172aeec8aeecfe13ebc75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2242aa63f4217b1e241e82fb94aa422864672464bdf60b92d2118be97fd13787d53858943d9ea3c1a2906f6b7cb6306290a8d530ef6312073215f4a33e38af64"} 04:52:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:00 INFO - Copying logs to upload dir... 04:52:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.730958 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-06 04:51:59.941424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:51:59.944618) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 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/a04f641a80e244a8ac1f0d6febbc81c71e0c18cefcdcae124737188e9c0a62d95d8f1c79a1fb46cdf577337f991af859d64956b9bdad655d98e74b77808a47b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2f69f2721bd29a4a943f10469d5a640dda549dcbe4d4328d951952dd06dc48420cae2056f5aadbaca23dafc88e828316157bf6bcb172aeec8aeecfe13ebc75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2242aa63f4217b1e241e82fb94aa422864672464bdf60b92d2118be97fd13787d53858943d9ea3c1a2906f6b7cb6306290a8d530ef6312073215f4a33e38af64"} build_url:https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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/a04f641a80e244a8ac1f0d6febbc81c71e0c18cefcdcae124737188e9c0a62d95d8f1c79a1fb46cdf577337f991af859d64956b9bdad655d98e74b77808a47b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2f69f2721bd29a4a943f10469d5a640dda549dcbe4d4328d951952dd06dc48420cae2056f5aadbaca23dafc88e828316157bf6bcb172aeec8aeecfe13ebc75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2242aa63f4217b1e241e82fb94aa422864672464bdf60b92d2118be97fd13787d53858943d9ea3c1a2906f6b7cb6306290a8d530ef6312073215f4a33e38af64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:51:59.977577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:51:59.977922) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475753479.64534-1393597750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:00.057506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:52:00.057861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:52:00.058228) ========= ========= Total master_lag: 0.19 =========