builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1476764384.35 results: success (0) buildid: 20161017183007 builduid: 30bef4653d534d289e3bb824957efae6 revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.354941) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.355404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.355695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.370932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.371320) ========= 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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 21:19:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.1K=0.2s 2016-10-17 21:19:44 (56.1 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.328087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.713480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.713898) ========= 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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015356 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:44.763122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 21:19:44.763459) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47be3ae8a710b35f040dffe7403877e764ab61ac --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 47be3ae8a710b35f040dffe7403877e764ab61ac --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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 21:19:44,852 truncating revision to first 12 chars 2016-10-17 21:19:44,852 Setting DEBUG logging. 2016-10-17 21:19:44,852 attempt 1/10 2016-10-17 21:19:44,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47be3ae8a710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 21:19:46,032 unpacking tar archive at: fx-team-47be3ae8a710/testing/mozharness/ program finished with exit code 0 elapsedTime=2.016315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 21:19:46.793442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:46.793798) ========= script_repo_revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:46.794194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:46.794458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:19:46.802750) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-17 21:19:46.803059) ========= /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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:19:46 INFO - MultiFileLogger online at 20161017 21:19:46 in /builds/slave/test 21:19:46 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 21:19:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:19:46 INFO - {'append_to_log': False, 21:19:46 INFO - 'base_work_dir': '/builds/slave/test', 21:19:46 INFO - 'blob_upload_branch': 'Fx-Team', 21:19:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:19:46 INFO - 'branch': 'Fx-Team', 21:19:46 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:46 INFO - 'config_files': ('talos/linux_config.py',), 21:19:46 INFO - 'default_actions': ('clobber', 21:19:46 INFO - 'read-buildbot-config', 21:19:46 INFO - 'download-and-extract', 21:19:46 INFO - 'populate-webroot', 21:19:46 INFO - 'create-virtualenv', 21:19:46 INFO - 'install', 21:19:46 INFO - 'run-tests'), 21:19:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:46 INFO - 'download_minidump_stackwalk': True, 21:19:46 INFO - 'download_symbols': 'ondemand', 21:19:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:46 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:46 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:46 INFO - 'installer_path': 'installer.exe', 21:19:46 INFO - 'log_level': 'info', 21:19:46 INFO - 'log_name': 'talos', 21:19:46 INFO - 'log_to_console': True, 21:19:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:19:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:19:46 INFO - 'opt_config_files': (), 21:19:46 INFO - 'pip_index': False, 21:19:46 INFO - 'sps_profile': False, 21:19:46 INFO - 'sps_profile_interval': 0, 21:19:46 INFO - 'suite': 'dromaeojs-e10s', 21:19:46 INFO - 'system_bits': '32', 21:19:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:46 INFO - 'title': 'talos-linux64-ix-017', 21:19:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:46 INFO - 'use_talos_json': True, 21:19:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:19:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:46 INFO - 'work_dir': 'build'} 21:19:46 INFO - [mozharness: 2016-10-18 04:19:46.993562Z] Running clobber step. 21:19:46 INFO - Running pre-action listener: _resource_record_pre_action 21:19:46 INFO - Running main action method: clobber 21:19:46 INFO - rmtree: /builds/slave/test/build 21:19:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:19:47 INFO - Running post-action listener: _resource_record_post_action 21:19:47 INFO - [mozharness: 2016-10-18 04:19:47.956159Z] Finished clobber step (success) 21:19:47 INFO - [mozharness: 2016-10-18 04:19:47.956257Z] Running read-buildbot-config step. 21:19:47 INFO - Running pre-action listener: _resource_record_pre_action 21:19:47 INFO - Running main action method: read_buildbot_config 21:19:47 INFO - Using buildbot properties: 21:19:47 INFO - { 21:19:47 INFO - "project": "", 21:19:47 INFO - "product": "firefox", 21:19:47 INFO - "script_repo_revision": "production", 21:19:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:19:47 INFO - "repository": "", 21:19:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:19:47 INFO - "buildid": "20161017183007", 21:19:47 INFO - "pgo_build": "True", 21:19:47 INFO - "basedir": "/builds/slave/test", 21:19:47 INFO - "buildnumber": 1257, 21:19:47 INFO - "slavename": "talos-linux64-ix-017", 21:19:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:19:47 INFO - "platform": "ubuntu64_hw", 21:19:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:19:47 INFO - "branch": "fx-team", 21:19:47 INFO - "repo_path": "integration/fx-team", 21:19:47 INFO - "revision": "47be3ae8a710b35f040dffe7403877e764ab61ac", 21:19:47 INFO - "stage_platform": "linux64-pgo", 21:19:47 INFO - "builduid": "30bef4653d534d289e3bb824957efae6", 21:19:47 INFO - "slavebuilddir": "test" 21:19:47 INFO - } 21:19:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:19:47 INFO - Running post-action listener: _resource_record_post_action 21:19:47 INFO - [mozharness: 2016-10-18 04:19:47.958679Z] Finished read-buildbot-config step (success) 21:19:47 INFO - [mozharness: 2016-10-18 04:19:47.958766Z] Running download-and-extract step. 21:19:47 INFO - Running pre-action listener: _resource_record_pre_action 21:19:47 INFO - Running main action method: download_and_extract 21:19:47 INFO - mkdir: /builds/slave/test/build/tests 21:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:47 INFO - trying https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:47 INFO - Downloading https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:19:48 INFO - Downloaded 1361 bytes. 21:19:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:48 INFO - Using the following test package requirements: 21:19:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:19:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:19:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'jsshell-linux-x86_64.zip'], 21:19:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:19:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:19:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:19:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:19:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:19:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:19:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:19:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:48 INFO - Fetch https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:19:49 INFO - Http code: 200 21:19:49 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 21:19:49 INFO - x-amz-cf-id: kcFExvIsVqb-7rmsJNu1i03kHrF_gwBXfV-iP5otRhTTPOqC2O8T9g== 21:19:49 INFO - x-amz-version-id: uWxph6booDAxolx6rO7xz_PSZ6_y3KSP 21:19:49 INFO - Expected file size: 22089727 21:19:49 INFO - Obtained file size: 22089727 21:19:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:19:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:19:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:53 INFO - Fetch https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:19:54 INFO - Http code: 200 21:19:54 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:19:54 INFO - x-amz-cf-id: dvGsdNUYkJRKw61-aBMIReXXdmvSSBUrHfN7gDvyfAk07iH4lhcpvQ== 21:19:54 INFO - x-amz-version-id: uWxph6booDAxolx6rO7xz_PSZ6_y3KSP 21:19:54 INFO - Expected file size: 22089727 21:19:54 INFO - Obtained file size: 22089727 21:19:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:19:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:19:59 INFO - Fetch https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:19:59 INFO - Http code: 200 21:19:59 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 21:19:59 INFO - x-amz-cf-id: p3KexsHxI38DU_J7P5X4FKutuPw8fkFuW6OuT9YzNJA5eiGRZUkwUg== 21:19:59 INFO - x-amz-version-id: q_ufXuhJ45iuoW1FQ4zlj2d3Jh0nN79W 21:20:00 INFO - Expected file size: 14409028 21:20:00 INFO - Obtained file size: 14409028 21:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:01 INFO - trying https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:20:01 INFO - Downloading https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:20:03 INFO - Downloaded 59493796 bytes. 21:20:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:20:03 INFO - mkdir: /builds/slave/test/properties 21:20:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:20:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:20:03 INFO - Contents: 21:20:03 INFO - build_url:https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:20:04 INFO - Running post-action listener: _resource_record_post_action 21:20:04 INFO - Running post-action listener: set_extra_try_arguments 21:20:04 INFO - [mozharness: 2016-10-18 04:20:04.539029Z] Finished download-and-extract step (success) 21:20:04 INFO - [mozharness: 2016-10-18 04:20:04.539287Z] Running populate-webroot step. 21:20:04 INFO - Running pre-action listener: _resource_record_pre_action 21:20:04 INFO - Running main action method: populate_webroot 21:20:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:20:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:20:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:20:04 INFO - '--tppagecycles', 21:20:04 INFO - '7'], 21:20:04 INFO - 'tests': ['tsvgm']}}, 21:20:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:20:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:20:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:20:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:20:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['damp', 'tps']}, 21:20:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'tests': ['damp', 'tps']}, 21:20:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['dromaeo_dom']}, 21:20:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:20:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['basic_compositor_video']}, 21:20:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:20:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'other-e10s': {'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['a11yr', 21:20:04 INFO - 'ts_paint', 21:20:04 INFO - 'tpaint', 21:20:04 INFO - 'sessionrestore', 21:20:04 INFO - 'sessionrestore_no_auto_restore', 21:20:04 INFO - 'tabpaint']}, 21:20:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['tsvgx', 21:20:04 INFO - 'tsvgr_opacity', 21:20:04 INFO - 'tart', 21:20:04 INFO - 'tscrollx', 21:20:04 INFO - 'cart']}, 21:20:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:20:04 INFO - 'tsvgr_opacity', 21:20:04 INFO - 'tart', 21:20:04 INFO - 'tscrollx', 21:20:04 INFO - 'cart']}, 21:20:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'talos_options': ['--disable-e10s'], 21:20:04 INFO - 'tests': ['tp5o']}, 21:20:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'tests': ['tp5o']}, 21:20:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'talos_options': ['--disable-e10s', 21:20:04 INFO - '--xperf_path', 21:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:04 INFO - 'tests': ['tp5n']}, 21:20:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:04 INFO - 'talos_options': ['--xperf_path', 21:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:04 INFO - 'tests': ['tp5n']}}, 21:20:04 INFO - 'talos.zip': {'path': '', 21:20:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:20:04 INFO - Running post-action listener: _resource_record_post_action 21:20:04 INFO - [mozharness: 2016-10-18 04:20:04.557718Z] Finished populate-webroot step (success) 21:20:04 INFO - [mozharness: 2016-10-18 04:20:04.557806Z] Running create-virtualenv step. 21:20:04 INFO - Running pre-action listener: _resource_record_pre_action 21:20:04 INFO - Running main action method: create_virtualenv 21:20:04 INFO - Creating virtualenv /builds/slave/test/build/venv 21:20:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:20:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:20:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:20:04 INFO - Using real prefix '/usr' 21:20:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:20:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:20:07 INFO - Installing pip.................done. 21:20:07 INFO - Return code: 0 21:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:20:07 INFO - Reading from file tmpfile_stdout 21:20:07 INFO - Output received: 21:20:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:20:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:07 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:20:07 INFO - Using env: {'DISPLAY': ':0', 21:20:07 INFO - 'HOME': '/home/cltbld', 21:20:07 INFO - 'LANG': 'en_US.UTF-8', 21:20:07 INFO - 'LANGUAGE': 'en_US:en', 21:20:07 INFO - 'LOGNAME': 'cltbld', 21:20:07 INFO - 'MAIL': '/var/mail/cltbld', 21:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:07 INFO - 'MOZ_NO_REMOTE': '1', 21:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:07 INFO - 'NO_EM_RESTART': '1', 21:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:07 INFO - 'PWD': '/builds/slave/test', 21:20:07 INFO - 'SHELL': '/bin/bash', 21:20:07 INFO - 'SHLVL': '1', 21:20:07 INFO - 'TERM': 'linux', 21:20:07 INFO - 'TMOUT': '86400', 21:20:07 INFO - 'USER': 'cltbld', 21:20:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:07 INFO - '_': '/tools/buildbot/bin/python'} 21:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:20:07 INFO - Cleaning up... 21:20:07 INFO - Return code: 0 21:20:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:07 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:20:07 INFO - Using env: {'DISPLAY': ':0', 21:20:07 INFO - 'HOME': '/home/cltbld', 21:20:07 INFO - 'LANG': 'en_US.UTF-8', 21:20:07 INFO - 'LANGUAGE': 'en_US:en', 21:20:07 INFO - 'LOGNAME': 'cltbld', 21:20:07 INFO - 'MAIL': '/var/mail/cltbld', 21:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:07 INFO - 'MOZ_NO_REMOTE': '1', 21:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:07 INFO - 'NO_EM_RESTART': '1', 21:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:07 INFO - 'PWD': '/builds/slave/test', 21:20:07 INFO - 'SHELL': '/bin/bash', 21:20:07 INFO - 'SHLVL': '1', 21:20:07 INFO - 'TERM': 'linux', 21:20:07 INFO - 'TMOUT': '86400', 21:20:07 INFO - 'USER': 'cltbld', 21:20:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:07 INFO - '_': '/tools/buildbot/bin/python'} 21:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:07 INFO - Downloading/unpacking psutil>=3.1.1 21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:20:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:09 INFO - Installing collected packages: psutil 21:20:09 INFO - Running setup.py install for psutil 21:20:09 INFO - building 'psutil._psutil_linux' extension 21:20:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:20:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:20:10 INFO - building 'psutil._psutil_posix' extension 21:20:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:20:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:20:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:10 INFO - Successfully installed psutil 21:20:10 INFO - Cleaning up... 21:20:10 INFO - Return code: 0 21:20:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:10 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:20:10 INFO - Using env: {'DISPLAY': ':0', 21:20:10 INFO - 'HOME': '/home/cltbld', 21:20:10 INFO - 'LANG': 'en_US.UTF-8', 21:20:10 INFO - 'LANGUAGE': 'en_US:en', 21:20:10 INFO - 'LOGNAME': 'cltbld', 21:20:10 INFO - 'MAIL': '/var/mail/cltbld', 21:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:10 INFO - 'MOZ_NO_REMOTE': '1', 21:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:10 INFO - 'NO_EM_RESTART': '1', 21:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:10 INFO - 'PWD': '/builds/slave/test', 21:20:10 INFO - 'SHELL': '/bin/bash', 21:20:10 INFO - 'SHLVL': '1', 21:20:10 INFO - 'TERM': 'linux', 21:20:10 INFO - 'TMOUT': '86400', 21:20:10 INFO - 'USER': 'cltbld', 21:20:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:10 INFO - '_': '/tools/buildbot/bin/python'} 21:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:20:12 INFO - Installing collected packages: mozsystemmonitor 21:20:12 INFO - Running setup.py install for mozsystemmonitor 21:20:12 INFO - Successfully installed mozsystemmonitor 21:20:12 INFO - Cleaning up... 21:20:12 INFO - Return code: 0 21:20:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:12 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:20:12 INFO - Using env: {'DISPLAY': ':0', 21:20:12 INFO - 'HOME': '/home/cltbld', 21:20:12 INFO - 'LANG': 'en_US.UTF-8', 21:20:12 INFO - 'LANGUAGE': 'en_US:en', 21:20:12 INFO - 'LOGNAME': 'cltbld', 21:20:12 INFO - 'MAIL': '/var/mail/cltbld', 21:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:12 INFO - 'MOZ_NO_REMOTE': '1', 21:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:12 INFO - 'NO_EM_RESTART': '1', 21:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:12 INFO - 'PWD': '/builds/slave/test', 21:20:12 INFO - 'SHELL': '/bin/bash', 21:20:12 INFO - 'SHLVL': '1', 21:20:12 INFO - 'TERM': 'linux', 21:20:12 INFO - 'TMOUT': '86400', 21:20:12 INFO - 'USER': 'cltbld', 21:20:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:12 INFO - '_': '/tools/buildbot/bin/python'} 21:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:12 INFO - Downloading/unpacking jsonschema==2.5.1 21:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:20:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:20:15 INFO - warning: no files found matching '*.txt' 21:20:15 INFO - no previously-included directories found matching 'build' 21:20:15 INFO - no previously-included directories found matching 'dist' 21:20:15 INFO - no previously-included directories found matching '.git*' 21:20:15 INFO - Installing collected packages: jsonschema, functools32 21:20:15 INFO - Running setup.py install for functools32 21:20:15 INFO - warning: no files found matching '*.txt' 21:20:15 INFO - no previously-included directories found matching 'build' 21:20:15 INFO - no previously-included directories found matching 'dist' 21:20:15 INFO - no previously-included directories found matching '.git*' 21:20:15 INFO - Successfully installed jsonschema functools32 21:20:15 INFO - Cleaning up... 21:20:15 INFO - Return code: 0 21:20:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:20:15 INFO - Cleaning up... 21:20:15 INFO - Return code: 0 21:20:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:15 INFO - Downloading/unpacking blobuploader==1.2.4 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:17 INFO - Downloading blobuploader-1.2.4.tar.gz 21:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:20:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:20:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:18 INFO - Downloading docopt-0.6.1.tar.gz 21:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:20:18 INFO - Installing collected packages: blobuploader, requests, docopt 21:20:18 INFO - Running setup.py install for blobuploader 21:20:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:20:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:20:18 INFO - Running setup.py install for requests 21:20:19 INFO - Running setup.py install for docopt 21:20:19 INFO - Successfully installed blobuploader requests docopt 21:20:19 INFO - Cleaning up... 21:20:19 INFO - Return code: 0 21:20:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:19 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:19 INFO - Using env: {'DISPLAY': ':0', 21:20:19 INFO - 'HOME': '/home/cltbld', 21:20:19 INFO - 'LANG': 'en_US.UTF-8', 21:20:19 INFO - 'LANGUAGE': 'en_US:en', 21:20:19 INFO - 'LOGNAME': 'cltbld', 21:20:19 INFO - 'MAIL': '/var/mail/cltbld', 21:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:19 INFO - 'MOZ_NO_REMOTE': '1', 21:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:19 INFO - 'NO_EM_RESTART': '1', 21:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:19 INFO - 'PWD': '/builds/slave/test', 21:20:19 INFO - 'SHELL': '/bin/bash', 21:20:19 INFO - 'SHLVL': '1', 21:20:19 INFO - 'TERM': 'linux', 21:20:19 INFO - 'TMOUT': '86400', 21:20:19 INFO - 'USER': 'cltbld', 21:20:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:19 INFO - '_': '/tools/buildbot/bin/python'} 21:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:19 INFO - Running setup.py (path:/tmp/pip-1LA5gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:19 INFO - Running setup.py (path:/tmp/pip-iXVD8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:19 INFO - Running setup.py (path:/tmp/pip-B5bRoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:19 INFO - Running setup.py (path:/tmp/pip-IK5Bly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:19 INFO - Running setup.py (path:/tmp/pip-yLH9DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:19 INFO - Running setup.py (path:/tmp/pip-VcW5qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:19 INFO - Running setup.py (path:/tmp/pip-cFhcmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:19 INFO - Running setup.py (path:/tmp/pip-lGaYFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:20 INFO - Running setup.py (path:/tmp/pip-kKLH7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:20 INFO - Running setup.py (path:/tmp/pip-pYrFd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:20 INFO - Running setup.py (path:/tmp/pip-uoHNi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:20 INFO - Running setup.py (path:/tmp/pip-VQXnYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:20 INFO - Running setup.py (path:/tmp/pip-qBUTIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:20 INFO - Running setup.py (path:/tmp/pip-fhB0Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:20 INFO - Running setup.py (path:/tmp/pip-vp3E2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:20 INFO - Running setup.py (path:/tmp/pip-jM7d_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:20 INFO - Running setup.py (path:/tmp/pip-xACK96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:20:20 INFO - Running setup.py install for manifestparser 21:20:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:20:20 INFO - Running setup.py install for mozcrash 21:20:20 INFO - Running setup.py install for mozdebug 21:20:20 INFO - Running setup.py install for mozdevice 21:20:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for mozfile 21:20:21 INFO - Running setup.py install for mozhttpd 21:20:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for mozinfo 21:20:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for mozInstall 21:20:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for mozleak 21:20:21 INFO - Running setup.py install for mozlog 21:20:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for moznetwork 21:20:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Running setup.py install for mozprocess 21:20:21 INFO - Running setup.py install for mozprofile 21:20:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:20:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:20:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:20:22 INFO - Running setup.py install for mozrunner 21:20:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:20:22 INFO - Running setup.py install for mozscreenshot 21:20:22 INFO - Running setup.py install for moztest 21:20:22 INFO - Running setup.py install for mozversion 21:20:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:20:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:20:22 INFO - Cleaning up... 21:20:22 INFO - Return code: 0 21:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:22 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:22 INFO - Using env: {'DISPLAY': ':0', 21:20:22 INFO - 'HOME': '/home/cltbld', 21:20:22 INFO - 'LANG': 'en_US.UTF-8', 21:20:22 INFO - 'LANGUAGE': 'en_US:en', 21:20:22 INFO - 'LOGNAME': 'cltbld', 21:20:22 INFO - 'MAIL': '/var/mail/cltbld', 21:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:22 INFO - 'MOZ_NO_REMOTE': '1', 21:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:22 INFO - 'NO_EM_RESTART': '1', 21:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:22 INFO - 'PWD': '/builds/slave/test', 21:20:22 INFO - 'SHELL': '/bin/bash', 21:20:22 INFO - 'SHLVL': '1', 21:20:22 INFO - 'TERM': 'linux', 21:20:22 INFO - 'TMOUT': '86400', 21:20:22 INFO - 'USER': 'cltbld', 21:20:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:22 INFO - '_': '/tools/buildbot/bin/python'} 21:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:22 INFO - Running setup.py (path:/tmp/pip-l5rUZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:22 INFO - Running setup.py (path:/tmp/pip-iTfnHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:22 INFO - Running setup.py (path:/tmp/pip-wzcIhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:22 INFO - Running setup.py (path:/tmp/pip-PEFyWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:23 INFO - Running setup.py (path:/tmp/pip-EO1TGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:23 INFO - Running setup.py (path:/tmp/pip-LJQZV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:23 INFO - Running setup.py (path:/tmp/pip-tcgvge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:23 INFO - Running setup.py (path:/tmp/pip-_pvnfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:23 INFO - Running setup.py (path:/tmp/pip-_keNGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:23 INFO - Running setup.py (path:/tmp/pip-Q2bAYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:23 INFO - Running setup.py (path:/tmp/pip-UKNoPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:23 INFO - Running setup.py (path:/tmp/pip-REARyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:23 INFO - Running setup.py (path:/tmp/pip-PPapUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:23 INFO - Running setup.py (path:/tmp/pip-BcnRSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:23 INFO - Running setup.py (path:/tmp/pip-yyMoLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:23 INFO - Running setup.py (path:/tmp/pip-nHk9fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:23 INFO - Running setup.py (path:/tmp/pip-7F4Ns3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:25 INFO - Downloading blessings-1.6.tar.gz 21:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:20:25 INFO - Installing collected packages: blessings 21:20:25 INFO - Running setup.py install for blessings 21:20:26 INFO - Successfully installed blessings 21:20:26 INFO - Cleaning up... 21:20:26 INFO - Return code: 0 21:20:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:26 INFO - Reading from file tmpfile_stdout 21:20:26 INFO - Current package versions: 21:20:26 INFO - argparse == 1.2.1 21:20:26 INFO - blessings == 1.6 21:20:26 INFO - blobuploader == 1.2.4 21:20:26 INFO - docopt == 0.6.1 21:20:26 INFO - functools32 == 3.2.3-2 21:20:26 INFO - jsonschema == 2.5.1 21:20:26 INFO - manifestparser == 1.1 21:20:26 INFO - mozInstall == 1.12 21:20:26 INFO - mozcrash == 0.17 21:20:26 INFO - mozdebug == 0.1 21:20:26 INFO - mozdevice == 0.48 21:20:26 INFO - mozfile == 1.2 21:20:26 INFO - mozhttpd == 0.7 21:20:26 INFO - mozinfo == 0.9 21:20:26 INFO - mozleak == 0.1 21:20:26 INFO - mozlog == 3.4 21:20:26 INFO - moznetwork == 0.27 21:20:26 INFO - mozprocess == 0.23 21:20:26 INFO - mozprofile == 0.28 21:20:26 INFO - mozrunner == 6.12 21:20:26 INFO - mozscreenshot == 0.1 21:20:26 INFO - mozsystemmonitor == 0.3 21:20:26 INFO - moztest == 0.7 21:20:26 INFO - mozversion == 1.4 21:20:26 INFO - psutil == 3.1.1 21:20:26 INFO - requests == 1.2.3 21:20:26 INFO - wsgiref == 0.1.2 21:20:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:26 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:26 INFO - Using env: {'DISPLAY': ':0', 21:20:26 INFO - 'HOME': '/home/cltbld', 21:20:26 INFO - 'LANG': 'en_US.UTF-8', 21:20:26 INFO - 'LANGUAGE': 'en_US:en', 21:20:26 INFO - 'LOGNAME': 'cltbld', 21:20:26 INFO - 'MAIL': '/var/mail/cltbld', 21:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:26 INFO - 'MOZ_NO_REMOTE': '1', 21:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:26 INFO - 'NO_EM_RESTART': '1', 21:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:26 INFO - 'PWD': '/builds/slave/test', 21:20:26 INFO - 'SHELL': '/bin/bash', 21:20:26 INFO - 'SHLVL': '1', 21:20:26 INFO - 'TERM': 'linux', 21:20:26 INFO - 'TMOUT': '86400', 21:20:26 INFO - 'USER': 'cltbld', 21:20:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:26 INFO - '_': '/tools/buildbot/bin/python'} 21:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:20:26 INFO - Cleaning up... 21:20:26 INFO - Return code: 0 21:20:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:26 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 0x7f70e157af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, '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': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:20:26 INFO - Using env: {'DISPLAY': ':0', 21:20:26 INFO - 'HOME': '/home/cltbld', 21:20:26 INFO - 'LANG': 'en_US.UTF-8', 21:20:26 INFO - 'LANGUAGE': 'en_US:en', 21:20:26 INFO - 'LOGNAME': 'cltbld', 21:20:26 INFO - 'MAIL': '/var/mail/cltbld', 21:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:26 INFO - 'MOZ_NO_REMOTE': '1', 21:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:26 INFO - 'NO_EM_RESTART': '1', 21:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:26 INFO - 'PWD': '/builds/slave/test', 21:20:26 INFO - 'SHELL': '/bin/bash', 21:20:26 INFO - 'SHLVL': '1', 21:20:26 INFO - 'TERM': 'linux', 21:20:26 INFO - 'TMOUT': '86400', 21:20:26 INFO - 'USER': 'cltbld', 21:20:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:26 INFO - '_': '/tools/buildbot/bin/python'} 21:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:20:26 INFO - Cleaning up... 21:20:26 INFO - Return code: 0 21:20:26 INFO - Running post-action listener: _resource_record_post_action 21:20:26 INFO - Running post-action listener: _start_resource_monitoring 21:20:26 INFO - Starting resource monitoring. 21:20:26 INFO - [mozharness: 2016-10-18 04:20:26.835206Z] Finished create-virtualenv step (success) 21:20:26 INFO - [mozharness: 2016-10-18 04:20:26.835729Z] Running install step. 21:20:26 INFO - Running pre-action listener: _resource_record_pre_action 21:20:26 INFO - Running main action method: install 21:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:27 INFO - Reading from file tmpfile_stdout 21:20:27 INFO - Detecting whether we're running mozinstall >=1.0... 21:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:20:27 INFO - Reading from file tmpfile_stdout 21:20:27 INFO - Output received: 21:20:27 INFO - Usage: mozinstall [options] installer 21:20:27 INFO - Options: 21:20:27 INFO - -h, --help show this help message and exit 21:20:27 INFO - -d DEST, --destination=DEST 21:20:27 INFO - Directory to install application into. [default: 21:20:27 INFO - "/builds/slave/test"] 21:20:27 INFO - --app=APP Application being installed. [default: firefox] 21:20:27 INFO - mkdir: /builds/slave/test/build/application 21:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:20:44 INFO - Reading from file tmpfile_stdout 21:20:44 INFO - Output received: 21:20:44 INFO - /builds/slave/test/build/application/firefox/firefox 21:20:44 INFO - Running post-action listener: _resource_record_post_action 21:20:44 INFO - [mozharness: 2016-10-18 04:20:44.088438Z] Finished install step (success) 21:20:44 INFO - [mozharness: 2016-10-18 04:20:44.088682Z] Running run-tests step. 21:20:44 INFO - Running pre-action listener: _resource_record_pre_action 21:20:44 INFO - Running main action method: run_tests 21:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:20:44 INFO - Python 2.7.3 21:20:44 INFO - Return code: 0 21:20:44 INFO - grabbing minidump binary from tooltool 21:20: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')]} 21:20:44 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 0x1601930>, '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 0x1602830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1602cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:20:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:20:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:20:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:20:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:44 INFO - Return code: 0 21:20:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:20:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:20:44 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/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:20:44 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/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 21:20:44 INFO - Using env: {'DISPLAY': ':0', 21:20:44 INFO - 'HOME': '/home/cltbld', 21:20:44 INFO - 'LANG': 'en_US.UTF-8', 21:20:44 INFO - 'LANGUAGE': 'en_US:en', 21:20:44 INFO - 'LOGNAME': 'cltbld', 21:20:44 INFO - 'MAIL': '/var/mail/cltbld', 21:20:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:20:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:44 INFO - 'MOZ_NO_REMOTE': '1', 21:20:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:44 INFO - 'NO_EM_RESTART': '1', 21:20:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:44 INFO - 'PWD': '/builds/slave/test', 21:20:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:20:44 INFO - 'SHELL': '/bin/bash', 21:20:44 INFO - 'SHLVL': '1', 21:20:44 INFO - 'TERM': 'linux', 21:20:44 INFO - 'TMOUT': '86400', 21:20:44 INFO - 'USER': 'cltbld', 21:20:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001', 21:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:44 INFO - '_': '/tools/buildbot/bin/python'} 21:20:44 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/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:20:44 INFO - mozversion application_buildid: 20161017183007 21:20:44 INFO - mozversion application_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 21:20:44 INFO - mozversion application_display_name: Nightly 21:20:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:44 INFO - mozversion application_name: Firefox 21:20:44 INFO - mozversion application_remotingname: firefox 21:20:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:20:44 INFO - mozversion application_vendor: Mozilla 21:20:44 INFO - mozversion application_version: 52.0a1 21:20:44 INFO - mozversion platform_buildid: 20161017183007 21:20:44 INFO - mozversion platform_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 21:20:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:20:44 INFO - mozversion platform_version: 52.0a1 21:20:44 INFO - using testdate: 1476764444 21:20:44 INFO - actual date: 1476764444 21:20:44 INFO - starting webserver on 'localhost:53273' 21:20:44 INFO - SUITE-START | Running 2 tests 21:20:44 INFO - TEST-START | dromaeo_css 21:20:44 INFO - operating with platform_type : linux_ 21:20:44 INFO - Initialising browser for dromaeo_css test... 21:20:44 INFO - TEST-INFO | started process 23622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dVpO_/profile http://localhost:53273/getInfo.html) 21:20:48 INFO - PROCESS | 23622 | __metrics Screen width/height:1600/1200 21:20:48 INFO - PROCESS | 23622 | colorDepth:24 21:20:48 INFO - PROCESS | 23622 | Browser inner width/height: 1024/697 21:20:48 INFO - PROCESS | 23622 | __metrics 21:20:49 ERROR - PROCESS | 23622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 21:20:49 INFO - TEST-INFO | 23622: exit 0 21:20:49 INFO - Browser initialized. 21:20:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:20:49 INFO - TEST-INFO | started process 23745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dVpO_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:02 INFO - PROCESS | 23745 | RSS: Main: 183123968 21:21:02 INFO - PROCESS | 23745 | 21:21:51 INFO - PROCESS | 23745 | 1476764511756 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:24:02 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53273/tests/dromaeo/cssquery-ext.html) 21:24:03 INFO - PROCESS | 23745 | RSS: Main: 196464640 21:24:03 INFO - PROCESS | 23745 | 21:27:05 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-ext.html (next: http://localhost:53273/tests/dromaeo/cssquery-jquery.html) 21:27:06 INFO - PROCESS | 23745 | RSS: Main: 194310144 21:27:06 INFO - PROCESS | 23745 | 21:30:08 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53273/tests/dromaeo/cssquery-mootools.html) 21:30:09 INFO - PROCESS | 23745 | RSS: Main: 196710400 21:30:09 INFO - PROCESS | 23745 | 21:33:10 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53273/tests/dromaeo/cssquery-prototype.html) 21:33:11 INFO - PROCESS | 23745 | RSS: Main: 193638400 21:33:11 INFO - PROCESS | 23745 | 21:36:14 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53273/tests/dromaeo/cssquery-yui.html) 21:36:14 INFO - PROCESS | 23745 | RSS: Main: 197398528 21:36:14 INFO - PROCESS | 23745 | 21:39:17 INFO - PROCESS | 23745 | Cycle 1(1): loaded http://localhost:53273/tests/dromaeo/cssquery-yui.html (next: http://localhost:53273/tests/dromaeo/cssquery-dojo.html) 21:39:18 INFO - PROCESS | 23745 | RSS: Main: 196558848 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | __start_tp_report 21:39:18 INFO - PROCESS | 23745 | _x_x_mozilla_page_load 21:39:18 INFO - PROCESS | 23745 | _x_x_mozilla_page_load_details 21:39:18 INFO - PROCESS | 23745 | |i|pagename|runs| 21:39:18 INFO - PROCESS | 23745 | |0;dojo.html;2947.13059647404;2968.9109326720204;2980.538016607425;2983.627046619172;2997.5353820157884;5217.060929032773;5240.44975277596;5297.337832770903;5303.681779093257;5326.201069839522;5288.312519372485;5304.602154838383;5371.623986320959;5417.810376636819;5421.403645598991;4860.878478038042;4908.705477671333;4962.702237865721;4993.051320249159;5000.924986125211;4384.906679832884;4832.540908613676;5012.323336349601;5015.799368025275;5033.496650334974;4752.857414277577;4774.474807771142;4865.245886887538;4927.728974906378;4938.160512712848;4753.263244197155;4769.451513075971;4800.975995120037;4814.807407703723;4887;4764.618830493552;4774.259989701567;4780.426348838127;4785.832495862663;4838;5157.5616072633875;5165.66423182492;5193.844184674465;5231.189165679326;5343.973280133574;5516.117421212587;5517.337919449652;5643.351014633287;5651.830445086613;5725.312962444492;5704.087346024616;5704.201411802351;5721.742521586497;5721.856953576153;5726.513246374063;5332.706701131437;5358.490943360374;5358.678479291255;5363.088274993261;5411.594130440233;5619.129034999582;5659.405762394889;5670.319561652545;5700.857478563069;5712.65724056558;5486.945130548724;5497.917531237034;5503.807366742145;5533.778648854081;5535.059039963216;5524.088525393346;5556.666600004012;5559.8888022240135;5561.860953476195;5574.080276754371;5452.91820622691;5597.888042239132;5696.145578163226;5697.4302569742695;5770.942290577041;5703.40114288002;5718.971405142947;5724.255846739898;5730.19777231188;5734.455226753452;4413.58070983256;4416.381706561084;4429.202743506135;4429.247028005182;4477.462704475419;3849.2301539692176;3851.114243723903;3886.2227554489214;3922.9607703923166;3937.3897045957924;5391.892162156735;5488.121900495901;5488.17677348401;5499.367572729107;5549.139883318092;5741.942580574224;5772.653640781483;5776.971115144482;5788.5369170466265;5794.449527294901;5234.241035049897;5250.65870718402;5291;5327.280817089721;5438.293021907206;4918.827841025547;4920.901581968412;4922.704637721748;4976.178930476431;4977.527134922177;5833.066709326487;5834.445727655866;5839.386864379264;5873.647581145145;5931.733072011683;5507.228987941771;5531.778728850801;5629.971850140723;5695.601307908407;5727.914081288867;5838.357780644211;5847.94152058474;5870.119482077723;5943.138244954371;5945.910811337747;5568.55451563882;5618.297712785902;5624.690642014729;5632.85917852057;5646.181303711021;5474.151506516497;5481.479259470344;5515.641483303572;5642.576806739429;5657.15142728594;5563.471470210324;5567.137093750475;5574.832755017356;5584;5626.634268772516;5480.3971563128825;5500.477454641803;5541.3904470509015;5548.417416171405;5550.639208451437;5231.869203269949;5232.816851410183;5310.097283461743;5340.51935325807;5533.889322213614;5505.284313039279;5513.476219759116;5520.613557050968;5576.9163462547285;5578.414266501959;5383.488568585978;5403.702796346239;5456.563474921917;5462.8361149165585;5468.152436372368 21:39:18 INFO - PROCESS | 23745 | |1;ext.html;571.5684658083144;580.7647902599443;582.5223316880158;584.5703407995126;586.4926838284885;41627;43771.56228437715;43822.34266486005;47163;47172;44646.33030504545;44910.32634510485;45139.32291015629;45177;45286.77356613221;8835.690750823707;8963.058878817728;8983.730488085335;8995.190432861042;9013.549322533847;8745.518996455192;8827.470351778913;8844.823103537925;8846.380753347235;8851.114888511162;8845.425047371933;8894.777630559256;8899.288056955427;8909;8916.821663566725;8735;8768;8790.912090879074;8815.426997245191;8829.337799664987;8678.132186781335;8749.47503149813;8773.166549177819;8784.165504277084;8793.208611224956;42095.57904420947;42343;42404.78797606023;42470.78764606188;42502.149957001;2699.0082017920186;2924.035068427414;2925.634295713036;2930.619019527469;3065.417570661567;31129.37741245185;31337;31670.841645791854;31758.682413175804;31872.203194920312;3342;3371.1909141806036;3378.3918894598964;3413.7269018478464;3443.707284880788;322741;324057;324801.9999999976;325055;325858;54889.72555137279;55047.72476137594;55079.44920550743;55448;55509.44490555124;59453;59550.70224648936;59692.70153649204;59865.401345985985;59950;16018.75971860423;16301.266443009856;16367.099809510592;16374.590635234214;16375.099369534551;12402.75194496123;12414.317212553216;12424.813627795591;12448.937755311166;12481.375931203585;15181.468648597245;16730;16800.915995419946;16863.57841053959;17047;5762.942370576325;5770.191673495557;5815.2149459822385;5855.180274761537;5880.176775251468;938.4463166731662;1050.165118730611;1115.2416356877402;1140.5575284267732;1142.5715356741223;31554.842225788725;31961.36077278488;32199.51700724491;32216.35567288641;32288.677113229038;1014.1785154025263;1082.1937656445998;1083.8807731149568;1147.1931707560625;1156.5373850459714;16367.349180434157;16407.261673224733;16407.5898102546;16416.425425110065;16511.752323715154;486369;486990;490163;490325;491940;55533.72233138808;55591.16613250804;55635;55669;55714;1289.426205338634;1334.6663334166458;1336.6257447914793;1339.1496399786206;1340.4571148684797;28322.433551328446;29545.852270739368;29578.408431831675;29957.70042299549;30317.69682303237;47409.28886066781;47695;47701.28448073212;47968.28047579219;47969;424402;424569;424946;426181;428258;26183.869080654476;26521.734782651925;26917.192484225503;26993.325166870985;27216.183514493805;43062;45813;46904;47115.76442117905;47470.52529474661;38706.80646596861;39128.2174356517;40428.59571404248;40477.392839108026;41498;38026;38555.80722096372;39332.41001384924;40022.799886000386;40752.96235188288;39692.04619307011;40030.19939601133;40099.599004009586;41254.38118428166;41472.792636036625;33133.83433082819;34863.65136348604;35410;36141.27717445689;36313;26968.865155674095;27381.589276160474;27577;27604.44791104207;27653.446931060862 21:39:18 INFO - PROCESS | 23745 | |2;jquery.html;377.20598140913376;380.7525108679359;380.94666746655463;388.4658594432655;390.08135840096554;17229.827701722978;19173.42479725607;19391;19734.309299174532;19856.20575176991;17308.480745577654;17794.199261033253;18376.908115459402;18894.338698145566;18899.52751181221;5156.561692256163;5187.610929180308;5361.865953351178;5377.946220537784;5391.514763671269;5159;5304.867378315535;5316.946830531703;5327.813526526573;5330;5289.338832645919;5291.523762861341;5327.547158491533;5331.067063263933;5331.946680533203;5703.885922281552;5730.169125476783;5747.425257474261;5774.307083150007;5783.306003279612;4938.629602779806;5068.797248110071;5116.155834287338;5117.257997590365;5122.052420302219;12015.098867584878;12074.456649450796;13015.154014988995;13384.732305353935;13411.530596429078;2031.9288824891205;2116.8518203725594;2202.3392982105465;2207.9779202207933;2219.2454565447665;9145;9421.38760980534;9618.278629102846;12604.68488287791;13777.586672399844;1752.7195648696147;1771.4951238896851;1776.413783451458;1803.9549011274692;1816.1010299901502;79344.60327698382;79748.60125699334;80316;80349;80966;10309.432981185957;10501.789964200672;10856.131509479223;10981.835272470918;11553.422328883522;12076.577319793765;12752.17110887808;14711.852881471263;14755.77866332006;14849;7493.587852668155;7527.774166775005;7601.733939312208;7684.654190561439;7791.805204869924;7425.888611670829;7450.627468626655;7565.810854728676;7717.536947783151;7729.265719756614;3595.1551385424405;3713.6472035156617;3930.390789427643;4014.698897582693;4081.673466122703;1910.4937191644226;1913.1112020848618;1940.3596813051659;1962.8037196280259;1979.8614097013358;884.91150884911;903.4398672822892;959.6689142245914;976.3897564022486;1004.7889943112028;18091.54771130732;19095.14071866769;19233.326833560757;19342;19532.414027579194;901.589776651622;947.8009617980164;956.4548207521646;962.4417837654144;987.7086259553449;10214.131798797036;10337.741556460998;10619.522121504397;10675.519601617945;10705;472349;478382;495088;500617;501350;88476.5576172115;92040;93424.06575934289;93475.53262233645;93536.53231733797;1001.2890847498212;1075.451519724946;1094.6332978452308;1100.526773487408;1104.5692180049787;15618.297176627306;16276.674466510367;16359.918200408922;16379.262933168275;16719.33122675128;39528.80235598804;39674.40488392734;40365.1926961465;40716.389254161804;40991.7950410258;55284.170737438166;56335;56449;57602;58487;7638.465307428649;7675.347595454449;7807.960960195162;7990.440669153103;8164.7958801030445;11146.944265278946;12036.157468977088;12106.697332566404;12283.508659653513;12533.811992820298;10390.948045259725;10756.569737210424;10888;11267.661970140909;11352.94323528377;10275.794484110127;10454.68635940923;10490.370577765358;10566.260361774603;10716.142708583451;11123.221374503708;11256.155788316073;11438;11581.594644187413;11660.475278612314;8284.130166332689;8362.372822038493;8385.28725058377;8523.659053637784;8681.652733890825;9315.86026209621;11092.500837462172;11140;11226.270292430965;11542.769144617228 21:39:18 INFO - PROCESS | 23745 | |3;mootools.html;1467.0830730793257;1493.7012597480502;1622;1718.6304944436943;1777.0403981849793;7748.1864404237585;7951.960240198805;8518.446300990432;9158.496282704456;9173.312001599881;8452.281556067726;8792.076831932634;8834.514101724402;9072.501012444312;9097.681581144661;2265.7394399644045;2281.3384118605586;2289.839711220215;2297.4830663100834;2298.804601608865;2182.3671135370723;2253.1663284584724;2278.7949084582383;2283.1894677389537;2287.4281429642588;2220.7002054722566;2221.566794475078;2243.304575581567;2268.897899594522;2284.2119468783244;2205.933821985343;2225.810806081485;2226.808657368308;2227.187076717003;2232.374935018181;2189.3650841256017;2196.121551379445;2204.7684993075654;2206.823454123666;2207;8920.598573064228;9009.414388064755;9010.504422256774;9020.639174433014;9032.232260257886;4909.386326709161;4924.507549245047;5028.522290382408;5052;5056.974715126437;3125.9218519536967;3173.698498642625;3359.344927739092;3375;3385.1367901185286;1045.4929359260752;1059.570873796106;1065.4938904020605;1077.095239998405;1093.059968427152;11517.884821151849;11870.347130907796;11907.404629768476;12326.19879707825;12399.380030998414;4203.705740598129;4266.0827921996915;4382;4397.912041759147;4425.137098265807;9264.25885929124;9446.669366572138;9473.052694730472;9544.95227523858;9591.376560523544;4920.3603531541385;4952.777125029383;4975.129352363322;4988.052270068675;5004.049230646166;4495.123450927038;4665.883352916137;4676.836310729108;4694.2958556216845;4725.527447255247;3533.840977156034;3642.3625865473437;3644.8177591120866;3690.3541880170865;3710.7959062251834;1146.2091157101572;1147.311613032174;1150.7986102432042;1155.8728539860608;1167.7781221567875;712.8716830970371;858.7423772868115;864.6152462154407;871.1419252036738;878.9252913502296;5090.08378491875;5130.769115389817;5227.764750586232;5243.4232234454175;5375.75809088592;409.8770368889381;413.93790931359933;414.819553494231;415.98752037438925;425.9829606815755;3374.4769560717637;3466.445368740989;3475.3396854597545;3476.687098161178;3592.28154369122;10827.458627068616;11391.430428478543;11410;11413.315201087962;11422.714432139262;11049.834252486218;11158.888411115784;11286.153538484647;11300.660980170607;11303.208775385809;8185.918140818516;8225.506469611842;8354.498730076215;8374.916250837536;8428.704995325133;5087.9745601273235;5092.261622064854;5144.125498665161;5290.809567847204;5352.223927530564;10093.243006774375;10100.64647737355;10284.228682848965;10296.60995765562;10376.221783366429;10120.443375614117;10333.121684656588;10369;10482.266241363031;10483.68548943533;6300.842478938063;6508.414242717989;6725.092112564741;6891.655417229018;7059.870420732658;8081.71713990031;8269.131741167092;8280.792980175544;8282.213189746964;8297.958510207653;6858;6991.370776630128;6995.475339349671;7076.929230707627;7095.290470952863;6668.966655166693;6950.8609827804175;7006.019157317877;7021.297870212938;7059.929400705927;6312.242530896322;6325.683715814283;6349.77775777864;6421.8073457796345;6434.195725534309;4395.604395604411;4421.712588681726;4542.477615074309;4550;4653.557911998355;4600.907981840278;4634.2353511671545;4681.204195286878;4693.296005599187;4731.266653668687 21:39:18 INFO - PROCESS | 23745 | |4;prototype.html;316.58685415532733;321.43106701138987;325.9429599820031;329.41857621298396;330.3393213572854;5511.200875872996;5564.582656300773;5605.411431799664;5615.83152505425;5625.212470254168;5454.7272636368125;5455.318085239345;5507.642003269794;5508;5527.208759576409;4069.97965010176;4140.846759684962;4152;4255.2340978364;4287.35689646554;4303.225419424502;4313.468718604897;4328.199283132615;4344.478662560481;4351.238533256684;4288.356746488021;4301.892452688692;4310.245707001262;4314.4391229140165;4325.351197320396;4059.451973983504;4164.541900390955;4232.724872883284;4233.491980962304;4311.6335111515555;3688.926221475582;3700.35243832331;3704.240630670706;3705.110773414388;3711.350513660099;5379.488948549921;5408.296921400193;5418.512333889968;5422.322209723785;5441.619086663935;4599.356090147382;4710.74090924999;4778.904421911542;4875.58557522611;4903.2645103234445;5627.212190293362;5641.984442800294;5650.124230744241;5684.54523638108;5697.743601537941;4043.433919251307;4057.6753859691153;4066.4916885389325;4067.857624983141;4074.227710945748;5861.589688721791;5899.380565040695;5923.437273459014;5947.494462970652;6046.365131661156;4096.938545921814;4135.710500265012;4141.730787498803;4153.91692166155;4169;4178.582141785858;4228.682848786292;4236.152769446123;4239.8092085856215;4251.234777739975;4759.833405830779;4880.6095512358925;4883.487233840396;4884.218525035977;4891.461939186686;5806.171056117394;5807.473748919234;5841.707914604252;5847.532197424196;5880.529557635379;1418.269591160553;1435.2106341512126;1435.454527279648;1442.2716528153426;1444.6532832120215;920.406337912043;927.221134247222;930.2046750028763;942.604106275366;945.2957546627806;5410.3778065522965;5433.6196466247775;5469.097598896137;5477.780888764484;5484.341878974548;5818.214541036906;5828.242328497268;5832.825015249549;5838;5839.708014599253;5336.279602253646;5355.919661205085;5397.190421436816;5455.9454405455435;5525.751341189576;3074.584931034282;3112.94159985606;3115.345777386729;3141.5601815745813;3142.0519278047755;5825.912611310834;5983.401659834069;6027.306859711101;6030.728617212236;6030.793841231771;6131.386861313833;6134.631922084689;6163.414475624809;6165.198524191826;6169.537284703575;6209.2548894133;6238.719257633417;6260.436560709558;6273.592216505913;6293.087502312231;5913.674747888907;5939.406059394199;5939.524838013035;5940.554458415722;5973.641581505123;5883.911741323969;5907;5928.2293301872205;5972.641641501524;6014.766972770659;5982;6107.129649064932;6108.633481991094;6245.843853903689;6262.342454042442;4023.3361495352938;4048.9797551012057;4081.4285999960625;4097.610726980932;4117.197146556393;5904.291485021825;5905.734241959208;5933.228680271537;5938.8218353449465;6048.395160483917;5779.884402312015;5804.593678442468;5814.4476274755525;5867.20792692998;5936.8812623748145;5759.568032397503;5865.208196893364;5872.412758724094;5876.324222714443;5911.55663325261;5371.731413429235;5746.505908463746;5768.480836724715;5798.1302804579655;5839.211706419579;5823.970880145572;5848.152017957457;5858.179854820243;5901;5916.171735956884;5739.598228123991;5758.712064396847;5786.103154011135;5812.244408226903;5836.503897168788 21:39:18 INFO - PROCESS | 23745 | |5;yui.html;524.7848382163312;536.2385412713945;539.5818240863331;546.3689438698302;595.3837777899873;12895.09734318598;14103.788443173347;14206.005579609418;14256.073355231903;14327.57017289483;12372.505099795997;12790.360481975911;12843.29361885096;12885.355732213375;12969.481220751159;661.7816120680164;788.1487992967582;794.1105961323326;795.0062421972534;796.8246985663174;667.5827607745159;775.9030121234846;796.7968168117151;805.8630032894422;812.2324403438753;835.419383528448;838.3167718309588;840.9663613455485;841.305922613843;841.3143288220081;830.3979614779267;832.4547421438907;833.2750507058837;835.6532039203723;838.828040251747;611.4008271893525;612.4732729852324;613.1507861611656;615.1848800339568;616.6454288783967;12980.935095324463;12990.220586764824;13000.154989925624;13000.674983125404;13002.414891329912;12889.613311600668;13042.804357934638;13532.120412173177;13600.31998400086;13916.58250252494;9673.419594824332;9931.255155863268;10028.298019138663;10202.948985255027;10745.194110441747;3448.2241495663275;3486.9651303486894;3516.788992660423;3576.338377400163;3604.098975256186;75357.62321188414;75650;80334.59832700799;80570.59714701447;81503;9526.190273826802;9651.227901767841;9726.319157659038;9796.51017449139;9890.752731181778;23057.423564411023;23253.53492930166;23474.295771126894;23519.41201469977;23532.29403117909;7276.599787011659;7324.926750732531;7455.888161677579;7457.701691932262;7468.701251949969;4151.2735271328;4174.123434078817;4208.831646734157;4315.805788739514;4350.564943505688;3230.418524665583;3346.096553930425;3346.6486018967657;3349.7822641528223;3350.66493350663;547.6823442403396;550.309361751;560.019965061143;572.8968785618546;575.3872126185599;524.9658772179796;560.7448610882038;585.988280234393;592.318833341652;630.9589876658002;8473.872891906627;8557.144285571518;8766.649334026695;8780;8937.150970657776;587.8853623543368;598.9251343582052;605.9575829691968;611.5077362722961;614.1126072824815;3891.494105766289;4030.879073627796;4142.668586513072;4154.169166166718;4157.542670306264;94412.08673089364;95582;98428.5078574617;98460.10779245527;116105;58154.7092264536;96889.51555242178;104538.47730761298;108207.45896270468;112847;59147.40852591591;59959;77218.61390693123;77515.2248477508;92015.53992229995;8365.979149928064;8804;8841.823163536821;9056.230220431336;9058.36591438593;39500.604993949695;47328;51245.231321530955;51356.22965655443;52070.47929520656;70746;75616.62191689006;77538;77917.61041194758;78510.2148978503;11775.76448471043;12369.752604948031;12477.625671229878;12537.310447925087;12847.293398863152;12659.620211393672;12869.163504372185;13107.475700971854;13631.113977591425;13735.931320343334;11841.574092071283;12426.130170887951;12545.686357841127;12960.935195323964;12972.481100755864;11854.288742675468;12132.93933530362;12360.4437800301;12361.690957726129;12490.750184996068;11218.887811122111;11882.346470944181;12068.456919438471;12265.325407102338;12338.81491777642;9774.951125244614;9817.509124543602;10186.643467478603;10471.3193642413;10486.737831554272;9131.497767622845;9580.66467673628;10491.422971736627;10641.255112142077;10655.25413221067 21:39:18 INFO - PROCESS | 23745 | __end_tp_report 21:39:18 INFO - PROCESS | 23745 | __start_cc_report 21:39:18 INFO - PROCESS | 23745 | _x_x_mozilla_cycle_collect,325 21:39:18 INFO - PROCESS | 23745 | __end_cc_report 21:39:18 INFO - PROCESS | 23745 | __startTimestamp1476765558167__endTimestamp 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | ------- Summary: start ------- 21:39:18 INFO - PROCESS | 23745 | Number of tests: 6 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#0] dojo.html Cycles:165 Average:5262.43 Median:5480.40 stddev:595.44 (10.9%) stddev-sans-first:568.89 21:39:18 INFO - PROCESS | 23745 | Values: 2947.1 2968.9 2980.5 2983.6 2997.5 5217.1 5240.4 5297.3 5303.7 5326.2 5288.3 5304.6 5371.6 5417.8 5421.4 4860.9 4908.7 4962.7 4993.1 5000.9 4384.9 4832.5 5012.3 5015.8 5033.5 4752.9 4774.5 4865.2 4927.7 4938.2 4753.3 4769.5 4801.0 4814.8 4887.0 4764.6 4774.3 4780.4 4785.8 4838.0 5157.6 5165.7 5193.8 5231.2 5344.0 5516.1 5517.3 5643.4 5651.8 5725.3 5704.1 5704.2 5721.7 5721.9 5726.5 5332.7 5358.5 5358.7 5363.1 5411.6 5619.1 5659.4 5670.3 5700.9 5712.7 5486.9 5497.9 5503.8 5533.8 5535.1 5524.1 5556.7 5559.9 5561.9 5574.1 5452.9 5597.9 5696.1 5697.4 5770.9 5703.4 5719.0 5724.3 5730.2 5734.5 4413.6 4416.4 4429.2 4429.2 4477.5 3849.2 3851.1 3886.2 3923.0 3937.4 5391.9 5488.1 5488.2 5499.4 5549.1 5741.9 5772.7 5777.0 5788.5 5794.4 5234.2 5250.7 5291.0 5327.3 5438.3 4918.8 4920.9 4922.7 4976.2 4977.5 5833.1 5834.4 5839.4 5873.6 5931.7 5507.2 5531.8 5630.0 5695.6 5727.9 5838.4 5847.9 5870.1 5943.1 5945.9 5568.6 5618.3 5624.7 5632.9 5646.2 5474.2 5481.5 5515.6 5642.6 5657.2 5563.5 5567.1 5574.8 5584.0 5626.6 5480.4 5500.5 5541.4 5548.4 5550.6 5231.9 5232.8 5310.1 5340.5 5533.9 5505.3 5513.5 5520.6 5576.9 5578.4 5383.5 5403.7 5456.6 5462.8 5468.2 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#1] ext.html Cycles:180 Average:57230.11 Median:41003.67 stddev:110814.46 (270.3%) stddev-sans-first:111043.67 21:39:18 INFO - PROCESS | 23745 | Values: 571.6 580.8 582.5 584.6 586.5 41627.0 43771.6 43822.3 47163.0 47172.0 44646.3 44910.3 45139.3 45177.0 45286.8 8835.7 8963.1 8983.7 8995.2 9013.5 8745.5 8827.5 8844.8 8846.4 8851.1 8845.4 8894.8 8899.3 8909.0 8916.8 8735.0 8768.0 8790.9 8815.4 8829.3 8678.1 8749.5 8773.2 8784.2 8793.2 42095.6 42343.0 42404.8 42470.8 42502.1 2699.0 2924.0 2925.6 2930.6 3065.4 31129.4 31337.0 31670.8 31758.7 31872.2 3342.0 3371.2 3378.4 3413.7 3443.7 322741.0 324057.0 324802.0 325055.0 325858.0 54889.7 55047.7 55079.4 55448.0 55509.4 59453.0 59550.7 59692.7 59865.4 59950.0 16018.8 16301.3 16367.1 16374.6 16375.1 12402.8 12414.3 12424.8 12448.9 12481.4 15181.5 16730.0 16800.9 16863.6 17047.0 5762.9 5770.2 5815.2 5855.2 5880.2 938.4 1050.2 1115.2 1140.6 1142.6 31554.8 31961.4 32199.5 32216.4 32288.7 1014.2 1082.2 1083.9 1147.2 1156.5 16367.3 16407.3 16407.6 16416.4 16511.8 486369.0 486990.0 490163.0 490325.0 491940.0 55533.7 55591.2 55635.0 55669.0 55714.0 1289.4 1334.7 1336.6 1339.1 1340.5 28322.4 29545.9 29578.4 29957.7 30317.7 47409.3 47695.0 47701.3 47968.3 47969.0 424402.0 424569.0 424946.0 426181.0 428258.0 26183.9 26521.7 26917.2 26993.3 27216.2 43062.0 45813.0 46904.0 47115.8 47470.5 38706.8 39128.2 40428.6 40477.4 41498.0 38026.0 38555.8 39332.4 40022.8 40753.0 39692.0 40030.2 40099.6 41254.4 41472.8 33133.8 34863.7 35410.0 36141.3 36313.0 26968.9 27381.6 27577.0 27604.4 27653.4 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#2] jquery.html Cycles:180 Average:28265.69 Median:380.85 stddev:80830.86 (21223.8%) stddev-sans-first:81030.49 21:39:18 INFO - PROCESS | 23745 | Values: 377.2 380.8 380.9 388.5 390.1 17229.8 19173.4 19391.0 19734.3 19856.2 17308.5 17794.2 18376.9 18894.3 18899.5 5156.6 5187.6 5361.9 5377.9 5391.5 5159.0 5304.9 5316.9 5327.8 5330.0 5289.3 5291.5 5327.5 5331.1 5331.9 5703.9 5730.2 5747.4 5774.3 5783.3 4938.6 5068.8 5116.2 5117.3 5122.1 12015.1 12074.5 13015.2 13384.7 13411.5 2031.9 2116.9 2202.3 2208.0 2219.2 9145.0 9421.4 9618.3 12604.7 13777.6 1752.7 1771.5 1776.4 1804.0 1816.1 79344.6 79748.6 80316.0 80349.0 80966.0 10309.4 10501.8 10856.1 10981.8 11553.4 12076.6 12752.2 14711.9 14755.8 14849.0 7493.6 7527.8 7601.7 7684.7 7791.8 7425.9 7450.6 7565.8 7717.5 7729.3 3595.2 3713.6 3930.4 4014.7 4081.7 1910.5 1913.1 1940.4 1962.8 1979.9 884.9 903.4 959.7 976.4 1004.8 18091.5 19095.1 19233.3 19342.0 19532.4 901.6 947.8 956.5 962.4 987.7 10214.1 10337.7 10619.5 10675.5 10705.0 472349.0 478382.0 495088.0 500617.0 501350.0 88476.6 92040.0 93424.1 93475.5 93536.5 1001.3 1075.5 1094.6 1100.5 1104.6 15618.3 16276.7 16359.9 16379.3 16719.3 39528.8 39674.4 40365.2 40716.4 40991.8 55284.2 56335.0 56449.0 57602.0 58487.0 7638.5 7675.3 7808.0 7990.4 8164.8 11146.9 12036.2 12106.7 12283.5 12533.8 10390.9 10756.6 10888.0 11267.7 11352.9 10275.8 10454.7 10490.4 10566.3 10716.1 11123.2 11256.2 11438.0 11581.6 11660.5 8284.1 8362.4 8385.3 8523.7 8681.7 9315.9 11092.5 11140.0 11226.3 11542.8 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#3] mootools.html Cycles:180 Average:5548.42 Median:4423.42 stddev:3328.60 (75.2%) stddev-sans-first:3323.81 21:39:18 INFO - PROCESS | 23745 | Values: 1467.1 1493.7 1622.0 1718.6 1777.0 7748.2 7952.0 8518.4 9158.5 9173.3 8452.3 8792.1 8834.5 9072.5 9097.7 2265.7 2281.3 2289.8 2297.5 2298.8 2182.4 2253.2 2278.8 2283.2 2287.4 2220.7 2221.6 2243.3 2268.9 2284.2 2205.9 2225.8 2226.8 2227.2 2232.4 2189.4 2196.1 2204.8 2206.8 2207.0 8920.6 9009.4 9010.5 9020.6 9032.2 4909.4 4924.5 5028.5 5052.0 5057.0 3125.9 3173.7 3359.3 3375.0 3385.1 1045.5 1059.6 1065.5 1077.1 1093.1 11517.9 11870.3 11907.4 12326.2 12399.4 4203.7 4266.1 4382.0 4397.9 4425.1 9264.3 9446.7 9473.1 9545.0 9591.4 4920.4 4952.8 4975.1 4988.1 5004.0 4495.1 4665.9 4676.8 4694.3 4725.5 3533.8 3642.4 3644.8 3690.4 3710.8 1146.2 1147.3 1150.8 1155.9 1167.8 712.9 858.7 864.6 871.1 878.9 5090.1 5130.8 5227.8 5243.4 5375.8 409.9 413.9 414.8 416.0 426.0 3374.5 3466.4 3475.3 3476.7 3592.3 10827.5 11391.4 11410.0 11413.3 11422.7 11049.8 11158.9 11286.2 11300.7 11303.2 8185.9 8225.5 8354.5 8374.9 8428.7 5088.0 5092.3 5144.1 5290.8 5352.2 10093.2 10100.6 10284.2 10296.6 10376.2 10120.4 10333.1 10369.0 10482.3 10483.7 6300.8 6508.4 6725.1 6891.7 7059.9 8081.7 8269.1 8280.8 8282.2 8298.0 6858.0 6991.4 6995.5 7076.9 7095.3 6669.0 6950.9 7006.0 7021.3 7059.9 6312.2 6325.7 6349.8 6421.8 6434.2 4395.6 4421.7 4542.5 4550.0 4653.6 4600.9 4634.2 4681.2 4693.3 4731.3 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#4] prototype.html Cycles:180 Average:4852.89 Median:5526.48 stddev:1457.31 (26.4%) stddev-sans-first:1421.07 21:39:18 INFO - PROCESS | 23745 | Values: 316.6 321.4 325.9 329.4 330.3 5511.2 5564.6 5605.4 5615.8 5625.2 5454.7 5455.3 5507.6 5508.0 5527.2 4070.0 4140.8 4152.0 4255.2 4287.4 4303.2 4313.5 4328.2 4344.5 4351.2 4288.4 4301.9 4310.2 4314.4 4325.4 4059.5 4164.5 4232.7 4233.5 4311.6 3688.9 3700.4 3704.2 3705.1 3711.4 5379.5 5408.3 5418.5 5422.3 5441.6 4599.4 4710.7 4778.9 4875.6 4903.3 5627.2 5642.0 5650.1 5684.5 5697.7 4043.4 4057.7 4066.5 4067.9 4074.2 5861.6 5899.4 5923.4 5947.5 6046.4 4096.9 4135.7 4141.7 4153.9 4169.0 4178.6 4228.7 4236.2 4239.8 4251.2 4759.8 4880.6 4883.5 4884.2 4891.5 5806.2 5807.5 5841.7 5847.5 5880.5 1418.3 1435.2 1435.5 1442.3 1444.7 920.4 927.2 930.2 942.6 945.3 5410.4 5433.6 5469.1 5477.8 5484.3 5818.2 5828.2 5832.8 5838.0 5839.7 5336.3 5355.9 5397.2 5455.9 5525.8 3074.6 3112.9 3115.3 3141.6 3142.1 5825.9 5983.4 6027.3 6030.7 6030.8 6131.4 6134.6 6163.4 6165.2 6169.5 6209.3 6238.7 6260.4 6273.6 6293.1 5913.7 5939.4 5939.5 5940.6 5973.6 5883.9 5907.0 5928.2 5972.6 6014.8 5982.0 6107.1 6108.6 6245.8 6262.3 4023.3 4049.0 4081.4 4097.6 4117.2 5904.3 5905.7 5933.2 5938.8 6048.4 5779.9 5804.6 5814.4 5867.2 5936.9 5759.6 5865.2 5872.4 5876.3 5911.6 5371.7 5746.5 5768.5 5798.1 5839.2 5824.0 5848.2 5858.2 5901.0 5916.2 5739.6 5758.7 5786.1 5812.2 5836.5 21:39:18 INFO - PROCESS | 23745 | 21:39:18 INFO - PROCESS | 23745 | [#5] yui.html Cycles:180 Average:19390.89 Median:537.91 stddev:28379.30 (5275.8%) stddev-sans-first:28423.56 21:39:18 INFO - PROCESS | 23745 | Values: 524.8 536.2 539.6 546.4 595.4 12895.1 14103.8 14206.0 14256.1 14327.6 12372.5 12790.4 12843.3 12885.4 12969.5 661.8 788.1 794.1 795.0 796.8 667.6 775.9 796.8 805.9 812.2 835.4 838.3 841.0 841.3 841.3 830.4 832.5 833.3 835.7 838.8 611.4 612.5 613.2 615.2 616.6 12980.9 12990.2 13000.2 13000.7 13002.4 12889.6 13042.8 13532.1 13600.3 13916.6 9673.4 9931.3 10028.3 10202.9 10745.2 3448.2 3487.0 3516.8 3576.3 3604.1 75357.6 75650.0 80334.6 80570.6 81503.0 9526.2 9651.2 9726.3 9796.5 9890.8 23057.4 23253.5 23474.3 23519.4 23532.3 7276.6 7324.9 7455.9 7457.7 7468.7 4151.3 4174.1 4208.8 4315.8 4350.6 3230.4 3346.1 3346.6 3349.8 3350.7 547.7 550.3 560.0 572.9 575.4 525.0 560.7 586.0 592.3 631.0 8473.9 8557.1 8766.6 8780.0 8937.2 587.9 598.9 606.0 611.5 614.1 3891.5 4030.9 4142.7 4154.2 4157.5 94412.1 95582.0 98428.5 98460.1 116105.0 58154.7 96889.5 104538.5 108207.5 112847.0 59147.4 59959.0 77218.6 77515.2 92015.5 8366.0 8804.0 8841.8 9056.2 9058.4 39500.6 47328.0 51245.2 51356.2 52070.5 70746.0 75616.6 77538.0 77917.6 78510.2 11775.8 12369.8 12477.6 12537.3 12847.3 12659.6 12869.2 13107.5 13631.1 13735.9 11841.6 12426.1 12545.7 12960.9 12972.5 11854.3 12132.9 12360.4 12361.7 12490.8 11218.9 11882.3 12068.5 12265.3 12338.8 9775.0 9817.5 10186.6 10471.3 10486.7 9131.5 9580.7 10491.4 10641.3 10655.3 21:39:18 INFO - PROCESS | 23745 | -------- Summary: end -------- 21:39:18 INFO - PROCESS | 23745 | 21:39:19 INFO - TEST-INFO | 23745: exit 0 21:39:19 INFO - TEST-OK | dromaeo_css | took 1114820ms 21:39:19 INFO - TEST-START | kraken 21:39:19 INFO - operating with platform_type : linux_ 21:39:19 INFO - Initialising browser for kraken test... 21:39:19 INFO - TEST-INFO | started process 24106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAf2ufa/profile http://localhost:53273/getInfo.html) 21:39:23 INFO - PROCESS | 24106 | __metrics Screen width/height:1600/1200 21:39:23 INFO - PROCESS | 24106 | colorDepth:24 21:39:23 INFO - PROCESS | 24106 | Browser inner width/height: 1024/697 21:39:23 INFO - PROCESS | 24106 | __metrics 21:39:23 ERROR - PROCESS | 24106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 21:39:24 INFO - TEST-INFO | 24106: exit 0 21:39:24 INFO - Browser initialized. 21:39:24 INFO - Running cycle 1/1 for kraken test... 21:39:24 INFO - TEST-INFO | started process 24228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAf2ufa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:36 INFO - PROCESS | 24228 | RSS: Main: 182517760 21:39:36 INFO - PROCESS | 24228 | 21:39:39 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:40 INFO - PROCESS | 24228 | RSS: Main: 197058560 21:39:40 INFO - PROCESS | 24228 | 21:39:43 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-dft) 21:39:43 INFO - PROCESS | 24228 | RSS: Main: 194490368 21:39:43 INFO - PROCESS | 24228 | 21:39:46 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-fft) 21:39:47 INFO - PROCESS | 24228 | RSS: Main: 191029248 21:39:47 INFO - PROCESS | 24228 | 21:39:49 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53273/tests/kraken/driver.html?testName=audio-oscillator) 21:39:50 INFO - PROCESS | 24228 | RSS: Main: 191213568 21:39:50 INFO - PROCESS | 24228 | 21:39:52 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:52 INFO - PROCESS | 24228 | RSS: Main: 192008192 21:39:52 INFO - PROCESS | 24228 | 21:39:55 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:56 INFO - PROCESS | 24228 | RSS: Main: 191422464 21:39:56 INFO - PROCESS | 24228 | 21:40:00 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53273/tests/kraken/driver.html?testName=imaging-desaturate) 21:40:00 INFO - PROCESS | 24228 | RSS: Main: 190103552 21:40:00 INFO - PROCESS | 24228 | 21:40:03 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53273/tests/kraken/driver.html?testName=json-parse-financial) 21:40:03 INFO - PROCESS | 24228 | RSS: Main: 191864832 21:40:03 INFO - PROCESS | 24228 | 21:40:05 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:40:06 INFO - PROCESS | 24228 | RSS: Main: 191934464 21:40:06 INFO - PROCESS | 24228 | 21:40:07 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:40:08 INFO - PROCESS | 24228 | RSS: Main: 191868928 21:40:08 INFO - PROCESS | 24228 | 21:40:10 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:40:11 INFO - PROCESS | 24228 | RSS: Main: 192094208 21:40:11 INFO - PROCESS | 24228 | 21:40:14 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:40:14 INFO - PROCESS | 24228 | RSS: Main: 191848448 21:40:14 INFO - PROCESS | 24228 | 21:40:17 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:40:18 INFO - PROCESS | 24228 | RSS: Main: 191594496 21:40:18 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | Cycle 1(1): loaded http://localhost:53273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53273/tests/kraken/driver.html?testName=ai-astar) 21:40:20 INFO - PROCESS | 24228 | RSS: Main: 193335296 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | __start_tp_report 21:40:20 INFO - PROCESS | 24228 | _x_x_mozilla_page_load 21:40:20 INFO - PROCESS | 24228 | _x_x_mozilla_page_load_details 21:40:20 INFO - PROCESS | 24228 | |i|pagename|runs| 21:40:20 INFO - PROCESS | 24228 | |0;ai-astar;106;111;112;112;114;113;112;113;112;112 21:40:20 INFO - PROCESS | 24228 | |1;audio-beat-detection;148;128;131;178;125;127;122;127;157;128 21:40:20 INFO - PROCESS | 24228 | |2;audio-dft;164;165;163;167;169;164;162;162;162;165 21:40:20 INFO - PROCESS | 24228 | |3;audio-fft;76;76;77;109;75;78;77;75;112;75 21:40:20 INFO - PROCESS | 24228 | |4;audio-oscillator;82;84;109;86;82;82;110;83;82;119 21:40:20 INFO - PROCESS | 24228 | |5;imaging-gaussian-blur;118;119;118;117;119;118;117;117;117;119 21:40:20 INFO - PROCESS | 24228 | |6;imaging-darkroom;149;148;147;147;149;148;149;148;148;149 21:40:20 INFO - PROCESS | 24228 | |7;imaging-desaturate;85;86;85;86;85;85;85;85;86;86 21:40:20 INFO - PROCESS | 24228 | |8;json-parse-financial;58;53;54;55;54;55;55;55;54;54 21:40:20 INFO - PROCESS | 24228 | |9;json-stringify-tinderbox;59;60;60;60;59;59;59;59;60;60 21:40:20 INFO - PROCESS | 24228 | |10;stanford-crypto-aes;82;82;85;83;82;85;82;81;90;83 21:40:20 INFO - PROCESS | 24228 | |11;stanford-crypto-ccm;137;145;137;145;145;145;142;131;224;135 21:40:20 INFO - PROCESS | 24228 | |12;stanford-crypto-pbkdf2;170;171;174;172;171;173;174;172;176;166 21:40:20 INFO - PROCESS | 24228 | |13;stanford-crypto-sha256-iterative;70;71;68;68;66;67;66;65;67;67 21:40:20 INFO - PROCESS | 24228 | __end_tp_report 21:40:20 INFO - PROCESS | 24228 | __start_cc_report 21:40:20 INFO - PROCESS | 24228 | _x_x_mozilla_cycle_collect,810 21:40:20 INFO - PROCESS | 24228 | __end_cc_report 21:40:20 INFO - PROCESS | 24228 | __startTimestamp1476765620347__endTimestamp 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ------- Summary: start ------- 21:40:20 INFO - PROCESS | 24228 | Number of tests: 14 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.16 (1.9%) stddev-sans-first:0.87 21:40:20 INFO - PROCESS | 24228 | Values: 106.0 111.0 112.0 112.0 114.0 113.0 112.0 113.0 112.0 112.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:129.50 stddev:18.16 (14.0%) stddev-sans-first:18.83 21:40:20 INFO - PROCESS | 24228 | Values: 148.0 128.0 131.0 178.0 125.0 127.0 122.0 127.0 157.0 128.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.31 (1.4%) stddev-sans-first:2.45 21:40:20 INFO - PROCESS | 24228 | Values: 164.0 165.0 163.0 167.0 169.0 164.0 162.0 162.0 162.0 165.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.54 (19.1%) stddev-sans-first:15.21 21:40:20 INFO - PROCESS | 24228 | Values: 76.0 76.0 77.0 109.0 75.0 78.0 77.0 75.0 112.0 75.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:82.00 stddev:14.62 (17.8%) stddev-sans-first:15.06 21:40:20 INFO - PROCESS | 24228 | Values: 82.0 84.0 109.0 86.0 82.0 82.0 110.0 83.0 82.0 119.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 21:40:20 INFO - PROCESS | 24228 | Values: 118.0 119.0 118.0 117.0 119.0 118.0 117.0 117.0 117.0 119.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 21:40:20 INFO - PROCESS | 24228 | Values: 149.0 148.0 147.0 147.0 149.0 148.0 149.0 148.0 148.0 149.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 21:40:20 INFO - PROCESS | 24228 | Values: 85.0 86.0 85.0 86.0 85.0 85.0 85.0 85.0 86.0 86.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:0.71 21:40:20 INFO - PROCESS | 24228 | Values: 58.0 53.0 54.0 55.0 54.0 55.0 55.0 55.0 54.0 54.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 21:40:20 INFO - PROCESS | 24228 | Values: 59.0 60.0 60.0 60.0 59.0 59.0 59.0 59.0 60.0 60.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:2.64 (3.2%) stddev-sans-first:2.74 21:40:20 INFO - PROCESS | 24228 | Values: 82.0 82.0 85.0 83.0 82.0 85.0 82.0 81.0 90.0 83.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:145.00 stddev:26.97 (18.6%) stddev-sans-first:28.27 21:40:20 INFO - PROCESS | 24228 | Values: 137.0 145.0 137.0 145.0 145.0 145.0 142.0 131.0 224.0 135.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.50 stddev:2.73 (1.6%) stddev-sans-first:2.80 21:40:20 INFO - PROCESS | 24228 | Values: 170.0 171.0 174.0 172.0 171.0 173.0 174.0 172.0 176.0 166.0 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.72 21:40:20 INFO - PROCESS | 24228 | Values: 70.0 71.0 68.0 68.0 66.0 67.0 66.0 65.0 67.0 67.0 21:40:20 INFO - PROCESS | 24228 | -------- Summary: end -------- 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | 21:40:20 INFO - PROCESS | 24228 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:40:20 INFO - PROCESS | 24228 | 21:40:21 INFO - TEST-INFO | 24228: exit 0 21:40:21 INFO - TEST-OK | kraken | took 62304ms 21:40:21 INFO - SUITE-END | took 1177s 21:40:21 INFO - Completed test suite (00:19:37) 21:40:21 INFO - javascript benchmark 21:40:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6956.463774202627, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.13059647404, 2968.9109326720204, 2980.538016607425, 2983.627046619172, 2997.5353820157884, 5217.060929032773, 5240.44975277596, 5297.337832770903, 5303.681779093257, 5326.201069839522, 5288.312519372485, 5304.602154838383, 5371.623986320959, 5417.810376636819, 5421.403645598991, 4860.878478038042, 4908.705477671333, 4962.702237865721, 4993.051320249159, 5000.924986125211, 4384.906679832884, 4832.540908613676, 5012.323336349601, 5015.799368025275, 5033.496650334974, 4752.857414277577, 4774.474807771142, 4865.245886887538, 4927.728974906378, 4938.160512712848, 4753.263244197155, 4769.451513075971, 4800.975995120037, 4814.807407703723, 4887.0, 4764.618830493552, 4774.259989701567, 4780.426348838127, 4785.832495862663, 4838.0, 5157.5616072633875, 5165.66423182492, 5193.844184674465, 5231.189165679326, 5343.973280133574, 5516.117421212587, 5517.337919449652, 5643.351014633287, 5651.830445086613, 5725.312962444492, 5704.087346024616, 5704.201411802351, 5721.742521586497, 5721.856953576153, 5726.513246374063, 5332.706701131437, 5358.490943360374, 5358.678479291255, 5363.088274993261, 5411.594130440233, 5619.129034999582, 5659.405762394889, 5670.319561652545, 5700.857478563069, 5712.65724056558, 5486.945130548724, 5497.917531237034, 5503.807366742145, 5533.778648854081, 5535.059039963216, 5524.088525393346, 5556.666600004012, 5559.8888022240135, 5561.860953476195, 5574.080276754371, 5452.91820622691, 5597.888042239132, 5696.145578163226, 5697.4302569742695, 5770.942290577041, 5703.40114288002, 5718.971405142947, 5724.255846739898, 5730.19777231188, 5734.455226753452, 4413.58070983256, 4416.381706561084, 4429.202743506135, 4429.247028005182, 4477.462704475419, 3849.2301539692176, 3851.114243723903, 3886.2227554489214, 3922.9607703923166, 3937.3897045957924, 5391.892162156735, 5488.121900495901, 5488.17677348401, 5499.367572729107, 5549.139883318092, 5741.942580574224, 5772.653640781483, 5776.971115144482, 5788.5369170466265, 5794.449527294901, 5234.241035049897, 5250.65870718402, 5291.0, 5327.280817089721, 5438.293021907206, 4918.827841025547, 4920.901581968412, 4922.704637721748, 4976.178930476431, 4977.527134922177, 5833.066709326487, 5834.445727655866, 5839.386864379264, 5873.647581145145, 5931.733072011683, 5507.228987941771, 5531.778728850801, 5629.971850140723, 5695.601307908407, 5727.914081288867, 5838.357780644211, 5847.94152058474, 5870.119482077723, 5943.138244954371, 5945.910811337747, 5568.55451563882, 5618.297712785902, 5624.690642014729, 5632.85917852057, 5646.181303711021, 5474.151506516497, 5481.479259470344, 5515.641483303572, 5642.576806739429, 5657.15142728594, 5563.471470210324, 5567.137093750475, 5574.832755017356, 5584.0, 5626.634268772516, 5480.3971563128825, 5500.477454641803, 5541.3904470509015, 5548.417416171405, 5550.639208451437, 5231.869203269949, 5232.816851410183, 5310.097283461743, 5340.51935325807, 5533.889322213614, 5505.284313039279, 5513.476219759116, 5520.613557050968, 5576.9163462547285, 5578.414266501959, 5383.488568585978, 5403.702796346239, 5456.563474921917, 5462.8361149165585, 5468.152436372368], "value": 5221.810429604655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5684658083144, 580.7647902599443, 582.5223316880158, 584.5703407995126, 586.4926838284885, 41627.0, 43771.56228437715, 43822.34266486005, 47163.0, 47172.0, 44646.33030504545, 44910.32634510485, 45139.32291015629, 45177.0, 45286.77356613221, 8835.690750823707, 8963.058878817728, 8983.730488085335, 8995.190432861042, 9013.549322533847, 8745.518996455192, 8827.470351778913, 8844.823103537925, 8846.380753347235, 8851.114888511162, 8845.425047371933, 8894.777630559256, 8899.288056955427, 8909.0, 8916.821663566725, 8735.0, 8768.0, 8790.912090879074, 8815.426997245191, 8829.337799664987, 8678.132186781335, 8749.47503149813, 8773.166549177819, 8784.165504277084, 8793.208611224956, 42095.57904420947, 42343.0, 42404.78797606023, 42470.78764606188, 42502.149957001, 2699.0082017920186, 2924.035068427414, 2925.634295713036, 2930.619019527469, 3065.417570661567, 31129.37741245185, 31337.0, 31670.841645791854, 31758.682413175804, 31872.203194920312, 3342.0, 3371.1909141806036, 3378.3918894598964, 3413.7269018478464, 3443.707284880788, 322741.0, 324057.0, 324801.9999999976, 325055.0, 325858.0, 54889.72555137279, 55047.72476137594, 55079.44920550743, 55448.0, 55509.44490555124, 59453.0, 59550.70224648936, 59692.70153649204, 59865.401345985985, 59950.0, 16018.75971860423, 16301.266443009856, 16367.099809510592, 16374.590635234214, 16375.099369534551, 12402.75194496123, 12414.317212553216, 12424.813627795591, 12448.937755311166, 12481.375931203585, 15181.468648597245, 16730.0, 16800.915995419946, 16863.57841053959, 17047.0, 5762.942370576325, 5770.191673495557, 5815.2149459822385, 5855.180274761537, 5880.176775251468, 938.4463166731662, 1050.165118730611, 1115.2416356877402, 1140.5575284267732, 1142.5715356741223, 31554.842225788725, 31961.36077278488, 32199.51700724491, 32216.35567288641, 32288.677113229038, 1014.1785154025263, 1082.1937656445998, 1083.8807731149568, 1147.1931707560625, 1156.5373850459714, 16367.349180434157, 16407.261673224733, 16407.5898102546, 16416.425425110065, 16511.752323715154, 486369.0, 486990.0, 490163.0, 490325.0, 491940.0, 55533.72233138808, 55591.16613250804, 55635.0, 55669.0, 55714.0, 1289.426205338634, 1334.6663334166458, 1336.6257447914793, 1339.1496399786206, 1340.4571148684797, 28322.433551328446, 29545.852270739368, 29578.408431831675, 29957.70042299549, 30317.69682303237, 47409.28886066781, 47695.0, 47701.28448073212, 47968.28047579219, 47969.0, 424402.0, 424569.0, 424946.0, 426181.0, 428258.0, 26183.869080654476, 26521.734782651925, 26917.192484225503, 26993.325166870985, 27216.183514493805, 43062.0, 45813.0, 46904.0, 47115.76442117905, 47470.52529474661, 38706.80646596861, 39128.2174356517, 40428.59571404248, 40477.392839108026, 41498.0, 38026.0, 38555.80722096372, 39332.41001384924, 40022.799886000386, 40752.96235188288, 39692.04619307011, 40030.19939601133, 40099.599004009586, 41254.38118428166, 41472.792636036625, 33133.83433082819, 34863.65136348604, 35410.0, 36141.27717445689, 36313.0, 26968.865155674095, 27381.589276160474, 27577.0, 27604.44791104207, 27653.446931060862], "value": 19265.75972788413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.20598140913376, 380.7525108679359, 380.94666746655463, 388.4658594432655, 390.08135840096554, 17229.827701722978, 19173.42479725607, 19391.0, 19734.309299174532, 19856.20575176991, 17308.480745577654, 17794.199261033253, 18376.908115459402, 18894.338698145566, 18899.52751181221, 5156.561692256163, 5187.610929180308, 5361.865953351178, 5377.946220537784, 5391.514763671269, 5159.0, 5304.867378315535, 5316.946830531703, 5327.813526526573, 5330.0, 5289.338832645919, 5291.523762861341, 5327.547158491533, 5331.067063263933, 5331.946680533203, 5703.885922281552, 5730.169125476783, 5747.425257474261, 5774.307083150007, 5783.306003279612, 4938.629602779806, 5068.797248110071, 5116.155834287338, 5117.257997590365, 5122.052420302219, 12015.098867584878, 12074.456649450796, 13015.154014988995, 13384.732305353935, 13411.530596429078, 2031.9288824891205, 2116.8518203725594, 2202.3392982105465, 2207.9779202207933, 2219.2454565447665, 9145.0, 9421.38760980534, 9618.278629102846, 12604.68488287791, 13777.586672399844, 1752.7195648696147, 1771.4951238896851, 1776.413783451458, 1803.9549011274692, 1816.1010299901502, 79344.60327698382, 79748.60125699334, 80316.0, 80349.0, 80966.0, 10309.432981185957, 10501.789964200672, 10856.131509479223, 10981.835272470918, 11553.422328883522, 12076.577319793765, 12752.17110887808, 14711.852881471263, 14755.77866332006, 14849.0, 7493.587852668155, 7527.774166775005, 7601.733939312208, 7684.654190561439, 7791.805204869924, 7425.888611670829, 7450.627468626655, 7565.810854728676, 7717.536947783151, 7729.265719756614, 3595.1551385424405, 3713.6472035156617, 3930.390789427643, 4014.698897582693, 4081.673466122703, 1910.4937191644226, 1913.1112020848618, 1940.3596813051659, 1962.8037196280259, 1979.8614097013358, 884.91150884911, 903.4398672822892, 959.6689142245914, 976.3897564022486, 1004.7889943112028, 18091.54771130732, 19095.14071866769, 19233.326833560757, 19342.0, 19532.414027579194, 901.589776651622, 947.8009617980164, 956.4548207521646, 962.4417837654144, 987.7086259553449, 10214.131798797036, 10337.741556460998, 10619.522121504397, 10675.519601617945, 10705.0, 472349.0, 478382.0, 495088.0, 500617.0, 501350.0, 88476.5576172115, 92040.0, 93424.06575934289, 93475.53262233645, 93536.53231733797, 1001.2890847498212, 1075.451519724946, 1094.6332978452308, 1100.526773487408, 1104.5692180049787, 15618.297176627306, 16276.674466510367, 16359.918200408922, 16379.262933168275, 16719.33122675128, 39528.80235598804, 39674.40488392734, 40365.1926961465, 40716.389254161804, 40991.7950410258, 55284.170737438166, 56335.0, 56449.0, 57602.0, 58487.0, 7638.465307428649, 7675.347595454449, 7807.960960195162, 7990.440669153103, 8164.7958801030445, 11146.944265278946, 12036.157468977088, 12106.697332566404, 12283.508659653513, 12533.811992820298, 10390.948045259725, 10756.569737210424, 10888.0, 11267.661970140909, 11352.94323528377, 10275.794484110127, 10454.68635940923, 10490.370577765358, 10566.260361774603, 10716.142708583451, 11123.221374503708, 11256.155788316073, 11438.0, 11581.594644187413, 11660.475278612314, 8284.130166332689, 8362.372822038493, 8385.28725058377, 8523.659053637784, 8681.652733890825, 9315.86026209621, 11092.500837462172, 11140.0, 11226.270292430965, 11542.769144617228], "value": 8675.95805464751, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.0830730793257, 1493.7012597480502, 1622.0, 1718.6304944436943, 1777.0403981849793, 7748.1864404237585, 7951.960240198805, 8518.446300990432, 9158.496282704456, 9173.312001599881, 8452.281556067726, 8792.076831932634, 8834.514101724402, 9072.501012444312, 9097.681581144661, 2265.7394399644045, 2281.3384118605586, 2289.839711220215, 2297.4830663100834, 2298.804601608865, 2182.3671135370723, 2253.1663284584724, 2278.7949084582383, 2283.1894677389537, 2287.4281429642588, 2220.7002054722566, 2221.566794475078, 2243.304575581567, 2268.897899594522, 2284.2119468783244, 2205.933821985343, 2225.810806081485, 2226.808657368308, 2227.187076717003, 2232.374935018181, 2189.3650841256017, 2196.121551379445, 2204.7684993075654, 2206.823454123666, 2207.0, 8920.598573064228, 9009.414388064755, 9010.504422256774, 9020.639174433014, 9032.232260257886, 4909.386326709161, 4924.507549245047, 5028.522290382408, 5052.0, 5056.974715126437, 3125.9218519536967, 3173.698498642625, 3359.344927739092, 3375.0, 3385.1367901185286, 1045.4929359260752, 1059.570873796106, 1065.4938904020605, 1077.095239998405, 1093.059968427152, 11517.884821151849, 11870.347130907796, 11907.404629768476, 12326.19879707825, 12399.380030998414, 4203.705740598129, 4266.0827921996915, 4382.0, 4397.912041759147, 4425.137098265807, 9264.25885929124, 9446.669366572138, 9473.052694730472, 9544.95227523858, 9591.376560523544, 4920.3603531541385, 4952.777125029383, 4975.129352363322, 4988.052270068675, 5004.049230646166, 4495.123450927038, 4665.883352916137, 4676.836310729108, 4694.2958556216845, 4725.527447255247, 3533.840977156034, 3642.3625865473437, 3644.8177591120866, 3690.3541880170865, 3710.7959062251834, 1146.2091157101572, 1147.311613032174, 1150.7986102432042, 1155.8728539860608, 1167.7781221567875, 712.8716830970371, 858.7423772868115, 864.6152462154407, 871.1419252036738, 878.9252913502296, 5090.08378491875, 5130.769115389817, 5227.764750586232, 5243.4232234454175, 5375.75809088592, 409.8770368889381, 413.93790931359933, 414.819553494231, 415.98752037438925, 425.9829606815755, 3374.4769560717637, 3466.445368740989, 3475.3396854597545, 3476.687098161178, 3592.28154369122, 10827.458627068616, 11391.430428478543, 11410.0, 11413.315201087962, 11422.714432139262, 11049.834252486218, 11158.888411115784, 11286.153538484647, 11300.660980170607, 11303.208775385809, 8185.918140818516, 8225.506469611842, 8354.498730076215, 8374.916250837536, 8428.704995325133, 5087.9745601273235, 5092.261622064854, 5144.125498665161, 5290.809567847204, 5352.223927530564, 10093.243006774375, 10100.64647737355, 10284.228682848965, 10296.60995765562, 10376.221783366429, 10120.443375614117, 10333.121684656588, 10369.0, 10482.266241363031, 10483.68548943533, 6300.842478938063, 6508.414242717989, 6725.092112564741, 6891.655417229018, 7059.870420732658, 8081.71713990031, 8269.131741167092, 8280.792980175544, 8282.213189746964, 8297.958510207653, 6858.0, 6991.370776630128, 6995.475339349671, 7076.929230707627, 7095.290470952863, 6668.966655166693, 6950.8609827804175, 7006.019157317877, 7021.297870212938, 7059.929400705927, 6312.242530896322, 6325.683715814283, 6349.77775777864, 6421.8073457796345, 6434.195725534309, 4395.604395604411, 4421.712588681726, 4542.477615074309, 4550.0, 4653.557911998355, 4600.907981840278, 4634.2353511671545, 4681.204195286878, 4693.296005599187, 4731.266653668687], "value": 4309.2993142230325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.58685415532733, 321.43106701138987, 325.9429599820031, 329.41857621298396, 330.3393213572854, 5511.200875872996, 5564.582656300773, 5605.411431799664, 5615.83152505425, 5625.212470254168, 5454.7272636368125, 5455.318085239345, 5507.642003269794, 5508.0, 5527.208759576409, 4069.97965010176, 4140.846759684962, 4152.0, 4255.2340978364, 4287.35689646554, 4303.225419424502, 4313.468718604897, 4328.199283132615, 4344.478662560481, 4351.238533256684, 4288.356746488021, 4301.892452688692, 4310.245707001262, 4314.4391229140165, 4325.351197320396, 4059.451973983504, 4164.541900390955, 4232.724872883284, 4233.491980962304, 4311.6335111515555, 3688.926221475582, 3700.35243832331, 3704.240630670706, 3705.110773414388, 3711.350513660099, 5379.488948549921, 5408.296921400193, 5418.512333889968, 5422.322209723785, 5441.619086663935, 4599.356090147382, 4710.74090924999, 4778.904421911542, 4875.58557522611, 4903.2645103234445, 5627.212190293362, 5641.984442800294, 5650.124230744241, 5684.54523638108, 5697.743601537941, 4043.433919251307, 4057.6753859691153, 4066.4916885389325, 4067.857624983141, 4074.227710945748, 5861.589688721791, 5899.380565040695, 5923.437273459014, 5947.494462970652, 6046.365131661156, 4096.938545921814, 4135.710500265012, 4141.730787498803, 4153.91692166155, 4169.0, 4178.582141785858, 4228.682848786292, 4236.152769446123, 4239.8092085856215, 4251.234777739975, 4759.833405830779, 4880.6095512358925, 4883.487233840396, 4884.218525035977, 4891.461939186686, 5806.171056117394, 5807.473748919234, 5841.707914604252, 5847.532197424196, 5880.529557635379, 1418.269591160553, 1435.2106341512126, 1435.454527279648, 1442.2716528153426, 1444.6532832120215, 920.406337912043, 927.221134247222, 930.2046750028763, 942.604106275366, 945.2957546627806, 5410.3778065522965, 5433.6196466247775, 5469.097598896137, 5477.780888764484, 5484.341878974548, 5818.214541036906, 5828.242328497268, 5832.825015249549, 5838.0, 5839.708014599253, 5336.279602253646, 5355.919661205085, 5397.190421436816, 5455.9454405455435, 5525.751341189576, 3074.584931034282, 3112.94159985606, 3115.345777386729, 3141.5601815745813, 3142.0519278047755, 5825.912611310834, 5983.401659834069, 6027.306859711101, 6030.728617212236, 6030.793841231771, 6131.386861313833, 6134.631922084689, 6163.414475624809, 6165.198524191826, 6169.537284703575, 6209.2548894133, 6238.719257633417, 6260.436560709558, 6273.592216505913, 6293.087502312231, 5913.674747888907, 5939.406059394199, 5939.524838013035, 5940.554458415722, 5973.641581505123, 5883.911741323969, 5907.0, 5928.2293301872205, 5972.641641501524, 6014.766972770659, 5982.0, 6107.129649064932, 6108.633481991094, 6245.843853903689, 6262.342454042442, 4023.3361495352938, 4048.9797551012057, 4081.4285999960625, 4097.610726980932, 4117.197146556393, 5904.291485021825, 5905.734241959208, 5933.228680271537, 5938.8218353449465, 6048.395160483917, 5779.884402312015, 5804.593678442468, 5814.4476274755525, 5867.20792692998, 5936.8812623748145, 5759.568032397503, 5865.208196893364, 5872.412758724094, 5876.324222714443, 5911.55663325261, 5371.731413429235, 5746.505908463746, 5768.480836724715, 5798.1302804579655, 5839.211706419579, 5823.970880145572, 5848.152017957457, 5858.179854820243, 5901.0, 5916.171735956884, 5739.598228123991, 5758.712064396847, 5786.103154011135, 5812.244408226903, 5836.503897168788], "value": 4378.197464298515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.7848382163312, 536.2385412713945, 539.5818240863331, 546.3689438698302, 595.3837777899873, 12895.09734318598, 14103.788443173347, 14206.005579609418, 14256.073355231903, 14327.57017289483, 12372.505099795997, 12790.360481975911, 12843.29361885096, 12885.355732213375, 12969.481220751159, 661.7816120680164, 788.1487992967582, 794.1105961323326, 795.0062421972534, 796.8246985663174, 667.5827607745159, 775.9030121234846, 796.7968168117151, 805.8630032894422, 812.2324403438753, 835.419383528448, 838.3167718309588, 840.9663613455485, 841.305922613843, 841.3143288220081, 830.3979614779267, 832.4547421438907, 833.2750507058837, 835.6532039203723, 838.828040251747, 611.4008271893525, 612.4732729852324, 613.1507861611656, 615.1848800339568, 616.6454288783967, 12980.935095324463, 12990.220586764824, 13000.154989925624, 13000.674983125404, 13002.414891329912, 12889.613311600668, 13042.804357934638, 13532.120412173177, 13600.31998400086, 13916.58250252494, 9673.419594824332, 9931.255155863268, 10028.298019138663, 10202.948985255027, 10745.194110441747, 3448.2241495663275, 3486.9651303486894, 3516.788992660423, 3576.338377400163, 3604.098975256186, 75357.62321188414, 75650.0, 80334.59832700799, 80570.59714701447, 81503.0, 9526.190273826802, 9651.227901767841, 9726.319157659038, 9796.51017449139, 9890.752731181778, 23057.423564411023, 23253.53492930166, 23474.295771126894, 23519.41201469977, 23532.29403117909, 7276.599787011659, 7324.926750732531, 7455.888161677579, 7457.701691932262, 7468.701251949969, 4151.2735271328, 4174.123434078817, 4208.831646734157, 4315.805788739514, 4350.564943505688, 3230.418524665583, 3346.096553930425, 3346.6486018967657, 3349.7822641528223, 3350.66493350663, 547.6823442403396, 550.309361751, 560.019965061143, 572.8968785618546, 575.3872126185599, 524.9658772179796, 560.7448610882038, 585.988280234393, 592.318833341652, 630.9589876658002, 8473.872891906627, 8557.144285571518, 8766.649334026695, 8780.0, 8937.150970657776, 587.8853623543368, 598.9251343582052, 605.9575829691968, 611.5077362722961, 614.1126072824815, 3891.494105766289, 4030.879073627796, 4142.668586513072, 4154.169166166718, 4157.542670306264, 94412.08673089364, 95582.0, 98428.5078574617, 98460.10779245527, 116105.0, 58154.7092264536, 96889.51555242178, 104538.47730761298, 108207.45896270468, 112847.0, 59147.40852591591, 59959.0, 77218.61390693123, 77515.2248477508, 92015.53992229995, 8365.979149928064, 8804.0, 8841.823163536821, 9056.230220431336, 9058.36591438593, 39500.604993949695, 47328.0, 51245.231321530955, 51356.22965655443, 52070.47929520656, 70746.0, 75616.62191689006, 77538.0, 77917.61041194758, 78510.2148978503, 11775.76448471043, 12369.752604948031, 12477.625671229878, 12537.310447925087, 12847.293398863152, 12659.620211393672, 12869.163504372185, 13107.475700971854, 13631.113977591425, 13735.931320343334, 11841.574092071283, 12426.130170887951, 12545.686357841127, 12960.935195323964, 12972.481100755864, 11854.288742675468, 12132.93933530362, 12360.4437800301, 12361.690957726129, 12490.750184996068, 11218.887811122111, 11882.346470944181, 12068.456919438471, 12265.325407102338, 12338.81491777642, 9774.951125244614, 9817.509124543602, 10186.643467478603, 10471.3193642413, 10486.737831554272, 9131.497767622845, 9580.66467673628, 10491.422971736627, 10641.255112142077, 10655.25413221067], "value": 6881.137138258817, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 112.0, 112.0, 114.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 131.0, 178.0, 125.0, 127.0, 122.0, 127.0, 157.0, 128.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 167.0, 169.0, 164.0, 162.0, 162.0, 162.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 109.0, 75.0, 78.0, 77.0, 75.0, 112.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 109.0, 86.0, 82.0, 82.0, 110.0, 83.0, 82.0, 119.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 149.0, 148.0, 149.0, 148.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 83.0, 82.0, 85.0, 82.0, 81.0, 90.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 137.0, 145.0, 145.0, 145.0, 142.0, 131.0, 224.0, 135.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 174.0, 172.0, 171.0, 173.0, 174.0, 172.0, 176.0, 166.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 68.0, 68.0, 66.0, 67.0, 66.0, 65.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 21:40:21 INFO - Return code: 0 21:40:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:40:21 ERROR - # TBPL SUCCESS # 21:40:21 INFO - Running post-action listener: _resource_record_post_action 21:40:21 INFO - [mozharness: 2016-10-18 04:40:21.630858Z] Finished run-tests step (success) 21:40:21 INFO - Running post-run listener: _resource_record_post_run 21:40:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392536064; Read time: 12; Write time: 270860 21:40:21 INFO - TinderboxPrint: CPU usage
13.4% 21:40:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:40:21 INFO - TinderboxPrint: I/O write bytes / time
392,536,064 / 270,860 21:40:21 INFO - TinderboxPrint: CPU idle
8,247.7 (86.6%) 21:40:21 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 21:40:21 INFO - TinderboxPrint: Swap in / out
0 / 0 21:40:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102825984; Read time: 0; Write time: 61496 21:40:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288464896; Read time: 0; Write time: 209332 21:40:22 INFO - Running post-run listener: _upload_blobber_files 21:40:22 INFO - Blob upload gear active. 21:40:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:40:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:40:22 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'] 21:40:22 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 21:40:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:40:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:40:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:23 INFO - (blobuploader) - INFO - Done attempting. 21:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:24 INFO - (blobuploader) - INFO - Done attempting. 21:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:40:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:27 INFO - (blobuploader) - INFO - Done attempting. 21:40:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:40:27 INFO - Return code: 0 21:40:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:40:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:40:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79d42a8e38def1a31eb716f4ada5ea67f8043114e2e55a66479c31a0dc3afc087ddf22721b4b22f07773889661157625e90c29f7ba45d7256a96db109e3a6a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13545129a8821b3407330a0d9c636c2fe924dfdfd2b35aac90732a45ce021348796fc9e6eaff69602676f3f74414839c09fcea3af2eb3c391af87cd541ee7ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b0f84942c4da4084edf1ae22c04df6214cd56703c4929b1ee27bc4cf1e855a07af072458dad5c92cf684f319b82bb34e923cd525c22420fa7361b1b8e6a668"} 21:40:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:40:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:40:27 INFO - Contents: 21:40:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79d42a8e38def1a31eb716f4ada5ea67f8043114e2e55a66479c31a0dc3afc087ddf22721b4b22f07773889661157625e90c29f7ba45d7256a96db109e3a6a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13545129a8821b3407330a0d9c636c2fe924dfdfd2b35aac90732a45ce021348796fc9e6eaff69602676f3f74414839c09fcea3af2eb3c391af87cd541ee7ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b0f84942c4da4084edf1ae22c04df6214cd56703c4929b1ee27bc4cf1e855a07af072458dad5c92cf684f319b82bb34e923cd525c22420fa7361b1b8e6a668"} 21:40:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:40:27 INFO - Copying logs to upload dir... 21:40:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:40:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.945492 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-17 21:40:27.760138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:40:27.764155) ========= 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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 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/79d42a8e38def1a31eb716f4ada5ea67f8043114e2e55a66479c31a0dc3afc087ddf22721b4b22f07773889661157625e90c29f7ba45d7256a96db109e3a6a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13545129a8821b3407330a0d9c636c2fe924dfdfd2b35aac90732a45ce021348796fc9e6eaff69602676f3f74414839c09fcea3af2eb3c391af87cd541ee7ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b0f84942c4da4084edf1ae22c04df6214cd56703c4929b1ee27bc4cf1e855a07af072458dad5c92cf684f319b82bb34e923cd525c22420fa7361b1b8e6a668"} build_url:https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/D20iLyvETMKIGK-ONxBN7g/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/79d42a8e38def1a31eb716f4ada5ea67f8043114e2e55a66479c31a0dc3afc087ddf22721b4b22f07773889661157625e90c29f7ba45d7256a96db109e3a6a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13545129a8821b3407330a0d9c636c2fe924dfdfd2b35aac90732a45ce021348796fc9e6eaff69602676f3f74414839c09fcea3af2eb3c391af87cd541ee7ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b0f84942c4da4084edf1ae22c04df6214cd56703c4929b1ee27bc4cf1e855a07af072458dad5c92cf684f319b82bb34e923cd525c22420fa7361b1b8e6a668"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:40:27.789195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:40:27.789516) ========= 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=0333a256a5e4f052382dd180000001b1-1476763983.33697-552246001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:40:27.871656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 21:40:27.871968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 21:40:27.872311) ========= ========= Total master_lag: 0.16 =========