builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1464816591.72 results: success (0) buildid: 20160601113032 builduid: 30c43aac810e4769be79033e3b0d179c revision: 359674b9970a98e42c97184e9d7c59c89bac06d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.723858) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.724390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.724739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.740300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.740708) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 14:29:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.8M=0s 2016-06-01 14:29:52 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.870956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.871763) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014934 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.924586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:51.925393) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 359674b9970a98e42c97184e9d7c59c89bac06d7 --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 359674b9970a98e42c97184e9d7c59c89bac06d7 --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=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 14:29:52,169 truncating revision to first 12 chars 2016-06-01 14:29:52,169 Setting DEBUG logging. 2016-06-01 14:29:52,169 attempt 1/10 2016-06-01 14:29:52,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/359674b9970a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 14:29:52,544 unpacking tar archive at: fx-team-359674b9970a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:52.644348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:52.644734) ========= script_repo_revision: 359674b9970a98e42c97184e9d7c59c89bac06d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:52.645196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:52.645504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 14:29:52.656000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 14:29:52.656339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:29:52 INFO - MultiFileLogger online at 20160601 14:29:52 in /builds/slave/test 14:29:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:29:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:52 INFO - {'append_to_log': False, 14:29:52 INFO - 'base_work_dir': '/builds/slave/test', 14:29:52 INFO - 'blob_upload_branch': 'Fx-Team', 14:29:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:52 INFO - 'branch': 'Fx-Team', 14:29:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:52 INFO - 'config_files': ('talos/linux_config.py',), 14:29:52 INFO - 'default_actions': ('clobber', 14:29:52 INFO - 'read-buildbot-config', 14:29:52 INFO - 'download-and-extract', 14:29:52 INFO - 'populate-webroot', 14:29:52 INFO - 'create-virtualenv', 14:29:52 INFO - 'install', 14:29:52 INFO - 'run-tests'), 14:29:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:52 INFO - 'download_minidump_stackwalk': True, 14:29:52 INFO - 'download_symbols': 'ondemand', 14:29:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:52 INFO - 'installer_path': 'installer.exe', 14:29:52 INFO - 'log_level': 'info', 14:29:52 INFO - 'log_name': 'talos', 14:29:52 INFO - 'log_to_console': True, 14:29:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:29:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:29:52 INFO - 'opt_config_files': (), 14:29:52 INFO - 'pip_index': False, 14:29:52 INFO - 'sps_profile': False, 14:29:52 INFO - 'sps_profile_interval': 0, 14:29:52 INFO - 'suite': 'dromaeojs', 14:29:52 INFO - 'system_bits': '32', 14:29:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:52 INFO - 'title': 'talos-linux64-ix-047', 14:29:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:52 INFO - 'use_talos_json': True, 14:29:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:52 INFO - 'work_dir': 'build'} 14:29:52 INFO - ##### 14:29:52 INFO - ##### Running clobber step. 14:29:52 INFO - ##### 14:29:52 INFO - Running pre-action listener: _resource_record_pre_action 14:29:52 INFO - Running main action method: clobber 14:29:52 INFO - rmtree: /builds/slave/test/build 14:29:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:53 INFO - Running post-action listener: _resource_record_post_action 14:29:53 INFO - ##### 14:29:53 INFO - ##### Finished clobber step (success) 14:29:53 INFO - ##### 14:29:53 INFO - ##### 14:29:53 INFO - ##### Running read-buildbot-config step. 14:29:53 INFO - ##### 14:29:53 INFO - Running pre-action listener: _resource_record_pre_action 14:29:53 INFO - Running main action method: read_buildbot_config 14:29:53 INFO - Using buildbot properties: 14:29:53 INFO - { 14:29:53 INFO - "project": "", 14:29:53 INFO - "product": "firefox", 14:29:53 INFO - "script_repo_revision": "production", 14:29:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:29:53 INFO - "repository": "", 14:29:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:29:53 INFO - "buildid": "20160601113032", 14:29:53 INFO - "pgo_build": "True", 14:29:53 INFO - "basedir": "/builds/slave/test", 14:29:53 INFO - "buildnumber": 1213, 14:29:53 INFO - "slavename": "talos-linux64-ix-047", 14:29:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:29:53 INFO - "platform": "ubuntu64_hw", 14:29:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:29:53 INFO - "branch": "fx-team", 14:29:53 INFO - "repo_path": "integration/fx-team", 14:29:53 INFO - "revision": "359674b9970a98e42c97184e9d7c59c89bac06d7", 14:29:53 INFO - "stage_platform": "linux64-pgo", 14:29:53 INFO - "builduid": "30c43aac810e4769be79033e3b0d179c", 14:29:53 INFO - "slavebuilddir": "test" 14:29:53 INFO - } 14:29:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:29:53 INFO - Running post-action listener: _resource_record_post_action 14:29:53 INFO - ##### 14:29:53 INFO - ##### Finished read-buildbot-config step (success) 14:29:53 INFO - ##### 14:29:53 INFO - ##### 14:29:53 INFO - ##### Running download-and-extract step. 14:29:53 INFO - ##### 14:29:53 INFO - Running pre-action listener: _resource_record_pre_action 14:29:53 INFO - Running main action method: download_and_extract 14:29:53 INFO - mkdir: /builds/slave/test/build/tests 14:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:53 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:29:54 INFO - Downloaded 1361 bytes. 14:29:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:29:54 INFO - Using the following test package requirements: 14:29:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:29:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:29:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:29:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'jsshell-linux-x86_64.zip'], 14:29:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:29:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:29:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:29:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:29:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:29:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:29:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:54 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:29:56 INFO - Downloaded 24422471 bytes. 14:29:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:29:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:29:57 INFO - Return code: 0 14:29:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:57 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:29:58 INFO - Downloaded 24422471 bytes. 14:29:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:29:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:29:59 INFO - Return code: 0 14:29:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:59 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:29:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:29:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:29:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:30:00 INFO - Downloaded 10834055 bytes. 14:30:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:30:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:30:01 INFO - Return code: 0 14:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:01 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:30:02 INFO - Downloaded 59027104 bytes. 14:30:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:02 INFO - mkdir: /builds/slave/test/properties 14:30:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:02 INFO - Contents: 14:30:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:03 INFO - Running post-action listener: _resource_record_post_action 14:30:03 INFO - Running post-action listener: set_extra_try_arguments 14:30:03 INFO - ##### 14:30:03 INFO - ##### Finished download-and-extract step (success) 14:30:03 INFO - ##### 14:30:03 INFO - ##### 14:30:03 INFO - ##### Running populate-webroot step. 14:30:03 INFO - ##### 14:30:03 INFO - Running pre-action listener: _resource_record_pre_action 14:30:03 INFO - Running main action method: populate_webroot 14:30:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:03 INFO - '--tppagecycles', 14:30:03 INFO - '7'], 14:30:03 INFO - 'tests': ['tsvgm']}}, 14:30:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['damp', 'tps']}, 14:30:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'tests': ['damp', 'tps']}, 14:30:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['dromaeo_dom']}, 14:30:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['a11yr', 14:30:03 INFO - 'ts_paint', 14:30:03 INFO - 'tpaint', 14:30:03 INFO - 'sessionrestore', 14:30:03 INFO - 'sessionrestore_no_auto_restore', 14:30:03 INFO - 'tabpaint']}, 14:30:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['tsvgx', 14:30:03 INFO - 'tsvgr_opacity', 14:30:03 INFO - 'tart', 14:30:03 INFO - 'tscrollx', 14:30:03 INFO - 'cart']}, 14:30:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:03 INFO - 'tsvgr_opacity', 14:30:03 INFO - 'tart', 14:30:03 INFO - 'tscrollx', 14:30:03 INFO - 'cart']}, 14:30:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'talos_options': ['--disable-e10s'], 14:30:03 INFO - 'tests': ['tp5o']}, 14:30:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'tests': ['tp5o']}, 14:30:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'talos_options': ['--disable-e10s', 14:30:03 INFO - '--xperf_path', 14:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:03 INFO - 'tests': ['tp5n']}, 14:30:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:03 INFO - 'talos_options': ['--xperf_path', 14:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:03 INFO - 'tests': ['tp5n']}}, 14:30:03 INFO - 'talos.zip': {'path': '', 14:30:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:03 INFO - Running post-action listener: _resource_record_post_action 14:30:03 INFO - ##### 14:30:03 INFO - ##### Finished populate-webroot step (success) 14:30:03 INFO - ##### 14:30:03 INFO - ##### 14:30:03 INFO - ##### Running create-virtualenv step. 14:30:03 INFO - ##### 14:30:03 INFO - Running pre-action listener: _resource_record_pre_action 14:30:03 INFO - Running main action method: create_virtualenv 14:30:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:30:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:03 INFO - Using real prefix '/usr' 14:30:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:06 INFO - Installing pip.................done. 14:30:06 INFO - Return code: 0 14:30:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:30:06 INFO - Using env: {'DISPLAY': ':0', 14:30:06 INFO - 'HOME': '/home/cltbld', 14:30:06 INFO - 'LANG': 'en_US.UTF-8', 14:30:06 INFO - 'LANGUAGE': 'en_US:en', 14:30:06 INFO - 'LOGNAME': 'cltbld', 14:30:06 INFO - 'MAIL': '/var/mail/cltbld', 14:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:06 INFO - 'MOZ_NO_REMOTE': '1', 14:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:06 INFO - 'NO_EM_RESTART': '1', 14:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:06 INFO - 'PWD': '/builds/slave/test', 14:30:06 INFO - 'SHELL': '/bin/bash', 14:30:06 INFO - 'SHLVL': '1', 14:30:06 INFO - 'TERM': 'linux', 14:30:06 INFO - 'TMOUT': '86400', 14:30:06 INFO - 'USER': 'cltbld', 14:30:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:06 INFO - '_': '/tools/buildbot/bin/python'} 14:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:30:06 INFO - Cleaning up... 14:30:06 INFO - Return code: 0 14:30:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:30:06 INFO - Using env: {'DISPLAY': ':0', 14:30:06 INFO - 'HOME': '/home/cltbld', 14:30:06 INFO - 'LANG': 'en_US.UTF-8', 14:30:06 INFO - 'LANGUAGE': 'en_US:en', 14:30:06 INFO - 'LOGNAME': 'cltbld', 14:30:06 INFO - 'MAIL': '/var/mail/cltbld', 14:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:06 INFO - 'MOZ_NO_REMOTE': '1', 14:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:06 INFO - 'NO_EM_RESTART': '1', 14:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:06 INFO - 'PWD': '/builds/slave/test', 14:30:06 INFO - 'SHELL': '/bin/bash', 14:30:06 INFO - 'SHLVL': '1', 14:30:06 INFO - 'TERM': 'linux', 14:30:06 INFO - 'TMOUT': '86400', 14:30:06 INFO - 'USER': 'cltbld', 14:30:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:06 INFO - '_': '/tools/buildbot/bin/python'} 14:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:06 INFO - Downloading/unpacking psutil>=3.1.1 14:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:08 INFO - Installing collected packages: psutil 14:30:08 INFO - Running setup.py install for psutil 14:30:08 INFO - building 'psutil._psutil_linux' extension 14:30:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:30:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:30:09 INFO - building 'psutil._psutil_posix' extension 14:30:09 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 14:30:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:09 INFO - Successfully installed psutil 14:30:09 INFO - Cleaning up... 14:30:09 INFO - Return code: 0 14:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:30:09 INFO - Using env: {'DISPLAY': ':0', 14:30:09 INFO - 'HOME': '/home/cltbld', 14:30:09 INFO - 'LANG': 'en_US.UTF-8', 14:30:09 INFO - 'LANGUAGE': 'en_US:en', 14:30:09 INFO - 'LOGNAME': 'cltbld', 14:30:09 INFO - 'MAIL': '/var/mail/cltbld', 14:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:09 INFO - 'MOZ_NO_REMOTE': '1', 14:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:09 INFO - 'NO_EM_RESTART': '1', 14:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:09 INFO - 'PWD': '/builds/slave/test', 14:30:09 INFO - 'SHELL': '/bin/bash', 14:30:09 INFO - 'SHLVL': '1', 14:30:09 INFO - 'TERM': 'linux', 14:30:09 INFO - 'TMOUT': '86400', 14:30:09 INFO - 'USER': 'cltbld', 14:30:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:09 INFO - '_': '/tools/buildbot/bin/python'} 14:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:11 INFO - Installing collected packages: mozsystemmonitor 14:30:11 INFO - Running setup.py install for mozsystemmonitor 14:30:11 INFO - Successfully installed mozsystemmonitor 14:30:11 INFO - Cleaning up... 14:30:11 INFO - Return code: 0 14:30:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:30:11 INFO - Using env: {'DISPLAY': ':0', 14:30:11 INFO - 'HOME': '/home/cltbld', 14:30:11 INFO - 'LANG': 'en_US.UTF-8', 14:30:11 INFO - 'LANGUAGE': 'en_US:en', 14:30:11 INFO - 'LOGNAME': 'cltbld', 14:30:11 INFO - 'MAIL': '/var/mail/cltbld', 14:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:11 INFO - 'MOZ_NO_REMOTE': '1', 14:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:11 INFO - 'NO_EM_RESTART': '1', 14:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:11 INFO - 'PWD': '/builds/slave/test', 14:30:11 INFO - 'SHELL': '/bin/bash', 14:30:11 INFO - 'SHLVL': '1', 14:30:11 INFO - 'TERM': 'linux', 14:30:11 INFO - 'TMOUT': '86400', 14:30:11 INFO - 'USER': 'cltbld', 14:30:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:11 INFO - '_': '/tools/buildbot/bin/python'} 14:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30:14 INFO - Downloading docopt-0.6.1.tar.gz 14:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:14 INFO - Running setup.py install for blobuploader 14:30:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:14 INFO - Running setup.py install for requests 14:30:14 INFO - Running setup.py install for docopt 14:30:15 INFO - Successfully installed blobuploader requests docopt 14:30:15 INFO - Cleaning up... 14:30:15 INFO - Return code: 0 14:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:15 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 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:15 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 14:30:15 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 14:30:15 INFO - Using env: {'DISPLAY': ':0', 14:30:15 INFO - 'HOME': '/home/cltbld', 14:30:15 INFO - 'LANG': 'en_US.UTF-8', 14:30:15 INFO - 'LANGUAGE': 'en_US:en', 14:30:15 INFO - 'LOGNAME': 'cltbld', 14:30:15 INFO - 'MAIL': '/var/mail/cltbld', 14:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:15 INFO - 'MOZ_NO_REMOTE': '1', 14:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:15 INFO - 'NO_EM_RESTART': '1', 14:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:15 INFO - 'PWD': '/builds/slave/test', 14:30:15 INFO - 'SHELL': '/bin/bash', 14:30:15 INFO - 'SHLVL': '1', 14:30:15 INFO - 'TERM': 'linux', 14:30:15 INFO - 'TMOUT': '86400', 14:30:15 INFO - 'USER': 'cltbld', 14:30:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:15 INFO - '_': '/tools/buildbot/bin/python'} 14:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:15 INFO - Running setup.py (path:/tmp/pip-lSflTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:15 INFO - Running setup.py (path:/tmp/pip-rUV5nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:15 INFO - Running setup.py (path:/tmp/pip-vjaQui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:15 INFO - Running setup.py (path:/tmp/pip-Atxoto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:15 INFO - Running setup.py (path:/tmp/pip-JuYFUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:15 INFO - Running setup.py (path:/tmp/pip-bxMrBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:15 INFO - Running setup.py (path:/tmp/pip-mMQ0Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:15 INFO - Running setup.py (path:/tmp/pip-IvFSt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:15 INFO - Running setup.py (path:/tmp/pip-1GePeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:15 INFO - Running setup.py (path:/tmp/pip-rAXspl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:16 INFO - Running setup.py (path:/tmp/pip-jBMqOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:16 INFO - Running setup.py (path:/tmp/pip-DtcjnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:16 INFO - Running setup.py (path:/tmp/pip-i8EelP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:16 INFO - Running setup.py (path:/tmp/pip-6QK334-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:16 INFO - Running setup.py (path:/tmp/pip-i2GrHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:16 INFO - Running setup.py (path:/tmp/pip-sJQa7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:16 INFO - Running setup.py (path:/tmp/pip-zUuoL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:16 INFO - Running setup.py install for manifestparser 14:30:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:16 INFO - Running setup.py install for mozcrash 14:30:16 INFO - Running setup.py install for mozdebug 14:30:16 INFO - Running setup.py install for mozdevice 14:30:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozfile 14:30:17 INFO - Running setup.py install for mozhttpd 14:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozinfo 14:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozInstall 14:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozleak 14:30:17 INFO - Running setup.py install for mozlog 14:30:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for moznetwork 14:30:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozprocess 14:30:17 INFO - Running setup.py install for mozprofile 14:30:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:17 INFO - Running setup.py install for mozrunner 14:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:18 INFO - Running setup.py install for mozscreenshot 14:30:18 INFO - Running setup.py install for moztest 14:30:18 INFO - Running setup.py install for mozversion 14:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:18 INFO - Cleaning up... 14:30:18 INFO - Return code: 0 14:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:18 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 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:18 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 14:30:18 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 14:30:18 INFO - Using env: {'DISPLAY': ':0', 14:30:18 INFO - 'HOME': '/home/cltbld', 14:30:18 INFO - 'LANG': 'en_US.UTF-8', 14:30:18 INFO - 'LANGUAGE': 'en_US:en', 14:30:18 INFO - 'LOGNAME': 'cltbld', 14:30:18 INFO - 'MAIL': '/var/mail/cltbld', 14:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:18 INFO - 'MOZ_NO_REMOTE': '1', 14:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:18 INFO - 'NO_EM_RESTART': '1', 14:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:18 INFO - 'PWD': '/builds/slave/test', 14:30:18 INFO - 'SHELL': '/bin/bash', 14:30:18 INFO - 'SHLVL': '1', 14:30:18 INFO - 'TERM': 'linux', 14:30:18 INFO - 'TMOUT': '86400', 14:30:18 INFO - 'USER': 'cltbld', 14:30:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:18 INFO - '_': '/tools/buildbot/bin/python'} 14:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:18 INFO - Running setup.py (path:/tmp/pip-kiqT3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:18 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)) 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:18 INFO - Running setup.py (path:/tmp/pip-n4W7nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:18 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)) 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:18 INFO - Running setup.py (path:/tmp/pip-IHde2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:18 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)) 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:18 INFO - Running setup.py (path:/tmp/pip-HsBc6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:18 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)) 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:18 INFO - Running setup.py (path:/tmp/pip-Vmukps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:18 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)) 14:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:18 INFO - Running setup.py (path:/tmp/pip-COUJYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:19 INFO - Running setup.py (path:/tmp/pip-GXjwlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:19 INFO - Running setup.py (path:/tmp/pip-nXt7On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:19 INFO - Running setup.py (path:/tmp/pip-Exaonc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:19 INFO - Running setup.py (path:/tmp/pip-hirLs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:19 INFO - Running setup.py (path:/tmp/pip-WGF6xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:19 INFO - Running setup.py (path:/tmp/pip-54v_KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:19 INFO - Running setup.py (path:/tmp/pip-fgIrO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:19 INFO - Running setup.py (path:/tmp/pip-TB1Awc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:19 INFO - Running setup.py (path:/tmp/pip-2Mnr1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:19 INFO - Running setup.py (path:/tmp/pip-ZoU_gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:19 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)) 14:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:19 INFO - Running setup.py (path:/tmp/pip-go222R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:19 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)) 14:30:19 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)) 14:30:19 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)) 14:30:19 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)) 14:30:19 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)) 14:30:19 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)) 14:30:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:19 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 14:30:19 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 14:30:19 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 14:30:19 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 14:30:19 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 14:30:19 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 14:30:21 INFO - Downloading blessings-1.6.tar.gz 14:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:21 INFO - Installing collected packages: blessings 14:30:21 INFO - Running setup.py install for blessings 14:30:21 INFO - Successfully installed blessings 14:30:21 INFO - Cleaning up... 14:30:21 INFO - Return code: 0 14:30:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:22 INFO - Reading from file tmpfile_stdout 14:30:22 INFO - Current package versions: 14:30:22 INFO - argparse == 1.2.1 14:30:22 INFO - blessings == 1.6 14:30:22 INFO - blobuploader == 1.2.4 14:30:22 INFO - docopt == 0.6.1 14:30:22 INFO - manifestparser == 1.1 14:30:22 INFO - mozInstall == 1.12 14:30:22 INFO - mozcrash == 0.17 14:30:22 INFO - mozdebug == 0.1 14:30:22 INFO - mozdevice == 0.48 14:30:22 INFO - mozfile == 1.2 14:30:22 INFO - mozhttpd == 0.7 14:30:22 INFO - mozinfo == 0.9 14:30:22 INFO - mozleak == 0.1 14:30:22 INFO - mozlog == 3.2 14:30:22 INFO - moznetwork == 0.27 14:30:22 INFO - mozprocess == 0.22 14:30:22 INFO - mozprofile == 0.28 14:30:22 INFO - mozrunner == 6.11 14:30:22 INFO - mozscreenshot == 0.1 14:30:22 INFO - mozsystemmonitor == 0.3 14:30:22 INFO - moztest == 0.7 14:30:22 INFO - mozversion == 1.4 14:30:22 INFO - psutil == 3.1.1 14:30:22 INFO - requests == 1.2.3 14:30:22 INFO - wsgiref == 0.1.2 14:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:22 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 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:22 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 14:30:22 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 14:30:22 INFO - Using env: {'DISPLAY': ':0', 14:30:22 INFO - 'HOME': '/home/cltbld', 14:30:22 INFO - 'LANG': 'en_US.UTF-8', 14:30:22 INFO - 'LANGUAGE': 'en_US:en', 14:30:22 INFO - 'LOGNAME': 'cltbld', 14:30:22 INFO - 'MAIL': '/var/mail/cltbld', 14:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:22 INFO - 'MOZ_NO_REMOTE': '1', 14:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:22 INFO - 'NO_EM_RESTART': '1', 14:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:22 INFO - 'PWD': '/builds/slave/test', 14:30:22 INFO - 'SHELL': '/bin/bash', 14:30:22 INFO - 'SHLVL': '1', 14:30:22 INFO - 'TERM': 'linux', 14:30:22 INFO - 'TMOUT': '86400', 14:30:22 INFO - 'USER': 'cltbld', 14:30:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:22 INFO - '_': '/tools/buildbot/bin/python'} 14:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 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)) 14:30:22 INFO - Cleaning up... 14:30:22 INFO - Return code: 0 14:30:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:22 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 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:22 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 14:30:22 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 14:30:22 INFO - Using env: {'DISPLAY': ':0', 14:30:22 INFO - 'HOME': '/home/cltbld', 14:30:22 INFO - 'LANG': 'en_US.UTF-8', 14:30:22 INFO - 'LANGUAGE': 'en_US:en', 14:30:22 INFO - 'LOGNAME': 'cltbld', 14:30:22 INFO - 'MAIL': '/var/mail/cltbld', 14:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:22 INFO - 'MOZ_NO_REMOTE': '1', 14:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:22 INFO - 'NO_EM_RESTART': '1', 14:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:22 INFO - 'PWD': '/builds/slave/test', 14:30:22 INFO - 'SHELL': '/bin/bash', 14:30:22 INFO - 'SHLVL': '1', 14:30:22 INFO - 'TERM': 'linux', 14:30:22 INFO - 'TMOUT': '86400', 14:30:22 INFO - 'USER': 'cltbld', 14:30:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:22 INFO - '_': '/tools/buildbot/bin/python'} 14:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:22 INFO - Downloading/unpacking jsonschema 14:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:24 INFO - Downloading/unpacking functools32 (from jsonschema) 14:30:24 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 14:30:24 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 14:30:24 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 14:30:24 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 14:30:24 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 14:30:24 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 14:30:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:24 INFO - warning: no files found matching '*.txt' 14:30:24 INFO - no previously-included directories found matching 'build' 14:30:24 INFO - no previously-included directories found matching 'dist' 14:30:24 INFO - no previously-included directories found matching '.git*' 14:30:24 INFO - Installing collected packages: jsonschema, functools32 14:30:24 INFO - Running setup.py install for functools32 14:30:24 INFO - warning: no files found matching '*.txt' 14:30:24 INFO - no previously-included directories found matching 'build' 14:30:24 INFO - no previously-included directories found matching 'dist' 14:30:24 INFO - no previously-included directories found matching '.git*' 14:30:24 INFO - Successfully installed jsonschema functools32 14:30:24 INFO - Cleaning up... 14:30:24 INFO - Return code: 0 14:30:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:30:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:24 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0c6b98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', '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 14:30:24 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', 'flake8'] in /builds/slave/test/build 14:30:24 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 flake8 14:30:24 INFO - Using env: {'DISPLAY': ':0', 14:30:24 INFO - 'HOME': '/home/cltbld', 14:30:24 INFO - 'LANG': 'en_US.UTF-8', 14:30:24 INFO - 'LANGUAGE': 'en_US:en', 14:30:24 INFO - 'LOGNAME': 'cltbld', 14:30:24 INFO - 'MAIL': '/var/mail/cltbld', 14:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:24 INFO - 'MOZ_NO_REMOTE': '1', 14:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:24 INFO - 'NO_EM_RESTART': '1', 14:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:24 INFO - 'PWD': '/builds/slave/test', 14:30:24 INFO - 'SHELL': '/bin/bash', 14:30:24 INFO - 'SHLVL': '1', 14:30:24 INFO - 'TERM': 'linux', 14:30:24 INFO - 'TMOUT': '86400', 14:30:24 INFO - 'USER': 'cltbld', 14:30:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:24 INFO - '_': '/tools/buildbot/bin/python'} 14:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:25 INFO - Downloading/unpacking flake8 14:30:25 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 14:30:25 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 14:30:25 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 14:30:25 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 14:30:25 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 14:30:25 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 14:30:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:30:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:30:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 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 14:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:30:27 INFO - no previously-included directories found matching 'docs/_build' 14:30:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:30:27 INFO - Running setup.py install for pep8 14:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:30:27 INFO - no previously-included directories found matching 'docs/_build' 14:30:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:30:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:30:27 INFO - Cleaning up... 14:30:28 INFO - Return code: 0 14:30:28 INFO - Running post-action listener: _resource_record_post_action 14:30:28 INFO - Running post-action listener: _start_resource_monitoring 14:30:28 INFO - Starting resource monitoring. 14:30:28 INFO - ##### 14:30:28 INFO - ##### Finished create-virtualenv step (success) 14:30:28 INFO - ##### 14:30:28 INFO - ##### 14:30:28 INFO - ##### Running install step. 14:30:28 INFO - ##### 14:30:28 INFO - Running pre-action listener: _resource_record_pre_action 14:30:28 INFO - Running main action method: install 14:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:28 INFO - Reading from file tmpfile_stdout 14:30:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:30:28 INFO - Reading from file tmpfile_stdout 14:30:28 INFO - Output received: 14:30:28 INFO - Usage: mozinstall [options] installer 14:30:28 INFO - Options: 14:30:28 INFO - -h, --help show this help message and exit 14:30:28 INFO - -d DEST, --destination=DEST 14:30:28 INFO - Directory to install application into. [default: 14:30:28 INFO - "/builds/slave/test"] 14:30:28 INFO - --app=APP Application being installed. [default: firefox] 14:30:28 INFO - mkdir: /builds/slave/test/build/application 14:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:30:45 INFO - Reading from file tmpfile_stdout 14:30:45 INFO - Output received: 14:30:45 INFO - /builds/slave/test/build/application/firefox/firefox 14:30:45 INFO - Running post-action listener: _resource_record_post_action 14:30:45 INFO - ##### 14:30:45 INFO - ##### Finished install step (success) 14:30:45 INFO - ##### 14:30:45 INFO - ##### 14:30:45 INFO - ##### Running run-tests step. 14:30:45 INFO - ##### 14:30:45 INFO - Running pre-action listener: _resource_record_pre_action 14:30:45 INFO - Running main action method: run_tests 14:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:30:45 INFO - Python 2.7.3 14:30:45 INFO - Return code: 0 14:30:45 INFO - grabbing minidump binary from tooltool 14:30:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:45 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 0x27199c0>, '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 0x271a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:30:45 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 14:30:45 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 14:30:45 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 14:30:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:30:45 INFO - Return code: 0 14:30:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:30:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:30:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:30:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:30:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:30:46 INFO - Return code: 0 14:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:30:46 INFO - Using env: {'DISPLAY': ':0', 14:30:46 INFO - 'HOME': '/home/cltbld', 14:30:46 INFO - 'LANG': 'en_US.UTF-8', 14:30:46 INFO - 'LANGUAGE': 'en_US:en', 14:30:46 INFO - 'LOGNAME': 'cltbld', 14:30:46 INFO - 'MAIL': '/var/mail/cltbld', 14:30:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:30:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:46 INFO - 'MOZ_NO_REMOTE': '1', 14:30:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:46 INFO - 'NO_EM_RESTART': '1', 14:30:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:46 INFO - 'PWD': '/builds/slave/test', 14:30:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:30:46 INFO - 'SHELL': '/bin/bash', 14:30:46 INFO - 'SHLVL': '1', 14:30:46 INFO - 'TERM': 'linux', 14:30:46 INFO - 'TMOUT': '86400', 14:30:46 INFO - 'USER': 'cltbld', 14:30:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210', 14:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:46 INFO - '_': '/tools/buildbot/bin/python'} 14:30:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:30:46 INFO - mozversion application_buildid: 20160601113032 14:30:46 INFO - mozversion application_changeset: 359674b9970a98e42c97184e9d7c59c89bac06d7 14:30:46 INFO - mozversion application_display_name: Nightly 14:30:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:30:46 INFO - mozversion application_name: Firefox 14:30:46 INFO - mozversion application_remotingname: firefox 14:30:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:30:46 INFO - mozversion application_vendor: Mozilla 14:30:46 INFO - mozversion application_version: 49.0a1 14:30:46 INFO - mozversion platform_buildid: 20160601113032 14:30:46 INFO - mozversion platform_changeset: 359674b9970a98e42c97184e9d7c59c89bac06d7 14:30:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:30:46 INFO - mozversion platform_version: 49.0a1 14:30:46 INFO - using testdate: 1464816646 14:30:46 INFO - actual date: 1464816646 14:30:46 INFO - starting webserver on 'localhost:47010' 14:30:46 INFO - SUITE-START | Running 2 tests 14:30:46 INFO - TEST-START | dromaeo_css 14:30:46 INFO - operating with platform_type : linux_ 14:30:46 INFO - Initialising browser for dromaeo_css test... 14:30:46 INFO - TEST-INFO | started process 32752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbF17TP/profile http://localhost:47010/getInfo.html) 14:30:50 INFO - PROCESS | 32752 | __metrics Screen width/height:1600/1200 14:30:50 INFO - PROCESS | 32752 | colorDepth:24 14:30:50 INFO - PROCESS | 32752 | Browser inner width/height: 1024/697 14:30:50 INFO - PROCESS | 32752 | __metrics 14:30:51 ERROR - PROCESS | 32752 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:30:52 INFO - TEST-INFO | 32752: exit 0 14:30:52 INFO - Browser initialized. 14:30:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:30:52 INFO - TEST-INFO | started process 364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbF17TP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:04 INFO - PROCESS | 364 | RSS: Main: 156217344 14:31:04 INFO - PROCESS | 364 | 14:31:55 INFO - PROCESS | 364 | 1464816715086 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] 14:34:02 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47010/tests/dromaeo/cssquery-ext.html) 14:34:03 INFO - PROCESS | 364 | RSS: Main: 264441856 14:34:03 INFO - PROCESS | 364 | 14:37:06 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-ext.html (next: http://localhost:47010/tests/dromaeo/cssquery-jquery.html) 14:37:07 INFO - PROCESS | 364 | RSS: Main: 237686784 14:37:07 INFO - PROCESS | 364 | 14:40:09 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47010/tests/dromaeo/cssquery-mootools.html) 14:40:09 INFO - PROCESS | 364 | RSS: Main: 245231616 14:40:09 INFO - PROCESS | 364 | 14:43:11 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47010/tests/dromaeo/cssquery-prototype.html) 14:43:12 INFO - PROCESS | 364 | RSS: Main: 237903872 14:43:12 INFO - PROCESS | 364 | 14:46:14 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47010/tests/dromaeo/cssquery-yui.html) 14:46:15 INFO - PROCESS | 364 | RSS: Main: 223866880 14:46:15 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | Cycle 1(1): loaded http://localhost:47010/tests/dromaeo/cssquery-yui.html (next: http://localhost:47010/tests/dromaeo/cssquery-dojo.html) 14:49:18 INFO - PROCESS | 364 | RSS: Main: 270987264 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | __start_tp_report 14:49:18 INFO - PROCESS | 364 | _x_x_mozilla_page_load 14:49:18 INFO - PROCESS | 364 | _x_x_mozilla_page_load_details 14:49:18 INFO - PROCESS | 364 | |i|pagename|runs| 14:49:18 INFO - PROCESS | 364 | |0;dojo.html;3147.213196700825;3157.5421563873224;3171.8572664230105;3200.5999250093737;3213.1645772099246;5243.10867152584;5288;5388.622796404248;5496.148097044959;5518.1998610201545;5386.245925570413;5429.945700542993;5439.755211015504;5441.183822426638;5490.752916118774;4855.417349918015;4895.412550493946;4947.109520286347;4959.752012399384;5074.4925507449325;4973.875653108683;4996.77514511846;5028.120078986181;5052.343195384613;5055.545000949914;4761.976190119045;4798.976005119987;4815.109204797123;4871.196252618313;4888.41339039314;4860.198067318888;4887.926681099786;4948.455669876311;4965.702057876539;4996.925046124311;4744.905101897943;4914.410270767531;4931.457539670633;4932.7040377577105;4951.752412379403;5256.894862102775;5317.494837990384;5323.680579165262;5396.379416367129;5419.783208671648;5875.794347197871;5876.1479585459865;5895.115732640095;5901.675407852566;5906.704664766745;5740.024195886709;5778.075507918755;5785.045467497858;5925.051991681354;5975.492083172936;5470.480304371078;5486.561075113981;5494.450554944514;5501.944980550184;5508.9724551376985;5970.701464926737;6009.549283803733;6037.909431358533;6038.788642397495;6040.848978775478;5613.775448982076;5696.914546281809;5728.856778580485;5745.425457454221;5767.798127065533;5874.94125058744;5877.676727780014;5924.644521328734;5928.318243402064;5932.762689492372;5844.88310233793;5857.414258574194;5859.853503662357;5862.912056319158;5864.501517371071;5635.605507614509;5734.541236701054;5793.275840519935;5799.565032622486;5845.444682755132;4464.0402313502755;4464.620507256919;4469.5306992765945;4469.865904022885;4507.188706032945;3900.2004589059175;3948.190620922704;3994.320965435883;4013.618706222904;4044.029432936133;5490.533304669068;5569.10894256917;5599.048161812501;5632;5643.689597072201;5881.206037185011;5884.588078834526;5893.852653683693;5894.8821023579285;5944.910826337608;5330.600204984564;5480.725963701799;5563.944360556424;5570.888582228414;5582.944170558242;5036.546710796046;5046.243063540425;5086.21163719624;5086.796528138833;5124.5131712487255;6067.484263837535;6073.51411887048;6075.574709770273;6081.969590152021;6083.756649733961;5589;5647.943520564906;5663.150527420919;5870.295564532284;5884.117382392676;5874;5889.67606781614;5910.408959104056;5923.022701254417;5932.436418540232;5532.197831314356;5562.332520097614;5566.749496272597;5573.888522229614;5577.581681373832;5626.690532020778;5712.714364281853;5752.798652047159;5767.5385969121535;5818.127280907897;5724.542036637143;5724.713764311685;5725.370209276893;5729.570282228766;5731.054376027909;5652.745626446737;5686.118651609007;5700.315962084576;5713.371529131875;5720.199172115824;5424.24060631504;5558.749856256397;5602.579806514446;5621.634593751393;5661.85845353853;5776.537876969916;5791.478766910998;5830.416958304136;5843.474087332161;5850;5496.587755918242;5614.7192640367;5660.235868157746;5667.03660377745;5697.145428185805 14:49:18 INFO - PROCESS | 364 | |1;ext.html;587.3685787778139;619.7180282971248;632.3644737039275;634.663628277013;645.0968643898544;30765.692343076564;31527.68472315276;43506.12987740247;44368.778156109256;44401.333979990326;41883.162336753245;45625.31562026572;45632.771836140855;45659.54340456594;45685.771571142184;8694.304455643565;8900.243479304267;8904.821903561924;8905.287576993825;8911.465312081296;8557.871631925525;8631.568421578895;8677.913220867773;8678.609462574168;8698;8754.430961987451;8761.605727742235;8794.780130496725;8796.956015219916;8799.604017819214;8721.30229581632;8766.211041006309;8768.824623507495;8770.605322760492;8778.47329160246;8709.869351959662;8829.161229683234;8829.646814127427;8834.955825220834;8835.469871807647;42202;42729.78635106836;42793.57206427927;42807.57192428067;42890.356644650354;3790.2419516096893;4000.899977500557;4185.958140418587;4283.721558098714;4324.891877703082;33165.50251746202;33449.16377090568;33467;33605.6639433605;33984;4262.595053469915;4281.400603915455;4320.503142138631;4411.977940110311;4454.732716037048;246919;248648;248757.7562112196;249568;249898;59244.11133832996;59298.40701593015;59710.70144649249;59746;59756;56897.715511423005;61356.69321653363;62586.68706656437;62778.372216277254;64439.355606444275;16586.336546538005;16839.66320673604;16840.663186736198;16851.07319097437;16861.662766744597;12698.936505317415;12792.232466052066;12866.806997895039;12884.677883052998;12897;15864.603384915239;16907.661846763243;17014.48956531306;17093.401730939608;17155.571110722332;6446.935530644727;6623.801285961429;6669.966650166815;6799.966000170067;6903.1371078615175;922.1884741427635;961.2310151878469;1091.328832767842;1122.0462606784167;1139.2082502660571;32226.677733222838;32478.837605812292;32601.673983260338;32863.835680821445;32998.19515341175;1114.765899161169;1163.5636636261402;1164.3654208456412;1187.8396416483663;1206.203905422417;17406.825931740776;18222.36221732233;18305.450836474927;19104.52238694016;19149.329773457863;539678;541450;545239;545376;547067;60514;60995.6950215255;61016.38983610107;61023.694881525305;61139.38860611426;1352.8579499152645;1390.65928847431;1403.5087719298165;1417.6101572067764;1419.836718777333;32777.50833737544;33767.15582110467;33907.83046084754;34150;34197.852342335245;52935.4706452946;52956.47043529515;53105.4689453116;53315.4668453326;53398.199027015406;479207;481670;483852;484221;485472;25092.498150036532;27071.59392609073;27370.726292736817;27664.723352766214;28093.157205283875;47536.52463475459;48097.5190248107;48549.757251213516;54120.188197176285;54937.450625493235;42402.36396453994;44930.3260451087;45568.41905484975;45847.541524585664;47495.525044750495;44804.77597611991;44940;45141;45157.548424515335;45667.77166114148;45656.31515527203;46523;47213.05573888572;47271.52728472671;47351.76324118357;38615.6138438612;40404.35349934795;40549.18901621892;40667.478392781864;40744.388834166915;29824.403511930075;30383;30781;30851.537226941164;31079.223019424695 14:49:18 INFO - PROCESS | 364 | |2;jquery.html;393.93106206413887;399.65629558579633;401.08952677422235;402.12537730436304;425.67826897483314;13650.841506883286;18080.186391612377;19378.90310548447;19384.127714252856;20584.07371668275;15511.689766204669;17276.22256998435;17927.10364481774;18520.166592503338;19522.902385488087;5649.406812284702;5853.941460585383;5862.88274234515;5889.85275368115;5902.232709747726;5700.857478563048;5739.655620662753;5739.827805165852;5755.453231942959;5819.476247137757;4217.873463796076;6192.78325258616;6465.644389558573;6489.935100648981;6592.406683398517;6453.580517266362;6502.349765023483;6529.281779004329;6573.967130164342;6583.045458408504;5631.774729010835;5692.37383887772;5747.109198074305;5769.624974376652;5769.855753606152;21975.780242197532;22356.441088972744;22762.317130486113;23489.17787877433;23603.173888913978;2244.517428752826;2246.2475070851283;2326.941826454335;2427.453822889853;2444.4499987502845;9676.649327140209;13395.531156409575;14496.492622758258;14835.554933352018;15159.166245856473;1900.0974537094908;1958.8237058664788;1991.442396129086;2016.4958760309923;2045.447729113146;82411.5879420605;83053.58473207595;84864;86451;86780;11148.65202570998;11156.665300041012;11184.664460066211;11236.550537978554;11260.662180134608;15340.463083792014;15599.064056156667;15667.529974100795;15688.137152456724;15708.978916370399;8262.380321475794;8362.080171181287;8396.454230475;8483.660653573788;8484.53335066565;8026.799330016796;8030.638621262057;8049.959750201211;8146.714864979697;8230.42387032914;4512.661550383735;4640.350350950869;4661.790219440133;4833.830815921426;4935.950640493549;1950.7073938909277;2005.31819181479;2006.7692215395125;2024.817766401031;2061.4640193549785;916.4363916191628;955.7515046088067;1038.7898098715063;1060.4432672846817;1083.9377410138109;19242.326518571783;19592.314269000515;19625;19674.50813729668;19694;999.0509016434416;1001.3140998416109;1035.5598870480017;1072.0780129088978;1088.3959402531514;10792.406417647106;11191.552337906556;11196.776064478665;11200.103991680646;11246.550137994389;495091.67179148557;498065;499736;522542;524507;90537;93831.53084234672;95771.52114239385;97062.02937970671;97581.5120924405;891.2736120062258;936.0592604432638;1054.6150655010865;1077.6443773554709;1080.5407701726735;16964.660706786042;17020.48938531846;17119.315227390765;17453.30186792514;17795.46613601594;38355;40762;42188.67962262105;42207.366889496065;42519.7874010628;58241.70879145577;59094.11358829535;59663;59891.40108599033;60540.39459605348;8570.100139485514;8702.347323950855;8798.648054077765;8811.911880881109;9004.32467564922;9409.341346105706;12801.167924084904;13357.799633005317;13449.731005380034;13481.932590336986;11441.256318339614;11508.82736758966;11580.131490138105;11697.532098715956;11961.342126183143;11632.651020469399;11804.70488237801;11809.291442513477;11929.463174157358;12046.216995895238;11808.350540720343;12014.819777703517;12142.089343299465;12248.38758062111;12270.570530031406;8565.957170214358;8608.870866936875;8653.870191947;8807.251383632463;8908.688195913372;11036.282641628268;11924.880751192377;11980.58067967617;12035.638930832089;12318.876811232132 14:49:18 INFO - PROCESS | 364 | |3;mootools.html;1326.044084974663;1454.9378953364048;1525.534711912867;1643.457658972539;1821.235081265869;8607.956960215199;8962.731118066453;9009.054049324817;9238;9243;8972.641094356219;9116.133967273116;9163;9178.495182764946;9192;2104.7579528354204;2303.239930822833;2346.7418583955796;2383.7735415135535;2387.450886296153;2404.5311164322966;2412.915547955813;2413.8310318277727;2414.3239892829947;2415.722191947922;2369.7037870266217;2389.2951579284154;2419.2984034629935;2421.8062554995645;2422.2612103308484;2019.3437132931856;2289.8626082435107;2342.601757701186;2361.9055237790467;2365.113082594027;2351.988240058806;2369.869657168855;2394.449276666359;2395;2395.7843794058617;9041.864372034424;9070.18368346852;9126.361154719172;9129.771755706093;9136.451812891248;5107.438181799999;5240.716024573966;5246.134387826004;5247.239150323182;5248.9737551312;3124.906252812419;3286.6384697683234;3297.142742886843;3378.476336167898;3389.474631432132;1073.9946300268527;1099.8185299425586;1123.7640095579939;1139.971500712489;1142.1034487926938;12584.74830503394;12620;12623.05327100462;12626.431810568454;12633.431495582721;4765.753629696181;4816.8554943351755;4836.540528649843;4843.588294994895;4874;10571.418571978615;10597.20520960931;10602.41686707223;10603.84094238587;10612.893871061346;5486.945130548724;5501.477359650907;5501.889962200814;5502.807401741;5505.201745746845;4370.147821174841;4869.902601947942;5000.374953130859;5010.799568017312;5062.164742817467;3863.7102217333813;4007.979960100239;4023.637872591481;4079.224947260011;4095.1604920991126;1306.6210798868412;1310.4234136979699;1312.2913626641698;1325.357201757147;1326.4561529772748;854.5385491834339;1008.294194064158;1020.1940467031111;1034.1881622925966;1035.5909415780725;6212.844678882973;6292.370762923762;6317.241930968313;6453.741850325934;6480.870382592416;1022.8721409823772;1048.2871647279771;1053.5153829238636;1083.5990683447176;1115.983260251097;3946.151577410813;3977.2244412339314;3987.641112299907;4000.699947503949;4046.6560342371226;11138.387388693538;11376.260543064674;11468.770624587629;11549.480273387719;11557.422128893522;11209.551617935354;11291.435428228555;11299.322040677585;11341;11345.886541134483;8110.229528194812;8399.286060684788;8419.579021048923;8443.28232100266;8582.699605513777;6079.179310792986;6164.537659675452;6216.222972128484;6222;6246.063090536456;10285.177185825265;10583.100436462986;10775.353478791298;10802;10806.621768238074;10791.946040269748;10973.561057557608;10996.615118470816;11008.174386921173;11113.44432778374;7451.2117091898635;7749.7675069748;7945.443818932619;8047.798805029921;8190.221928916743;8746.125387461203;8753.037165911617;8832.249258813074;8837.381383303107;8840.646374145219;7728.420368472274;7793.454458187873;7800.804979875322;7914.327282181079;8167.632456539589;7583.165851756192;7764.88352674699;7898.28915397594;7977.840443190988;8026.317762989977;7122.287771222836;7277.963610182127;7390.9260907390235;7393.445491588045;7397.926020739724;5206.609504287269;5312.5218730314455;5338.572914166935;5350.384705758732;5433.347998240079;5174.068667639861;5181.5077567631015;5235.554977826775;5434.64674796137;5466.80866169698 14:49:18 INFO - PROCESS | 364 | |4;prototype.html;319.6531763037103;329.38569567756133;333.6763339560627;336.517097964421;339.6942751523627;5143.691378517292;5274.156135018397;5324.813631522898;5373.408925018245;5392.9730351348235;5258.027264955986;5317.521423071923;5319.228711836781;5321.977648493567;5340.412554618989;4112.897177570562;4143.461350024492;4169.353750168729;4172.290710579194;4198.076423186909;3906.9413958790497;3969.7618142911374;4065.6340929316357;4182.33082706767;4197.391378250152;4016.9397459038137;4043.5349934757587;4127.938080928789;4146.3365861462025;4152.460180176573;4053.5135783705996;4072.287349713803;4099.795010249476;4117.485314335708;4117.691173161995;3417.5646228584055;3653.872114476007;3672.467492213641;3672.889813305605;3682.834272457719;5054.1407960646775;5087.465816089294;5088.23676448532;5098.286239926413;5102.209157580581;4716.905661886777;4728.574428301469;4740.976295118502;4742.739149346785;4750.952490475085;5411.56707463402;5506.64206826555;5547.5007249347755;5554.944450555483;5563.026470367669;3933.9213215735813;3943.881683549498;3944.861929832442;3951.8024098794945;3976.9005774855573;5661.46216109469;5683.374828768832;5700.2589663343915;5700.686462244575;5766.740496677701;3895.590962948906;3993.600639935983;4031.8185681644395;4046.858359957387;4053;4028.234635419261;4040.17176478827;4042.2319759245647;4049.311617025113;4055.2903241932545;4614.76926153691;4616.6075883550275;4620.636912110936;4623.398958135488;4651.674382793172;5485.424030476823;5491.9725401373535;5504.80733174345;5511.724413779295;5512.531434828004;1291.6125162451226;1390.7983342415293;1418.2625034981752;1418.8294656907885;1419.396082426851;882.1839798186652;910.1944778870615;910.1944778870748;915.2952226785338;921.4977837078808;4751.786169622375;4800.1119792838435;4822.9758851206225;4855.417349918032;4869.9269510957365;5036.445990940993;5046.511279172653;5055.559165637776;5076.923846142311;5126.384833819965;4757.785899634525;4769.642276829182;4833.477454601789;4871.95128048715;5044.470330615306;3017.5171972484736;3026.228311780482;3043.193553708269;3058.403611295776;3069.355435358555;5885.882282354414;5904.08486684556;5913.645181289136;5916.437938395846;5934.3175534814045;5648.49163575272;5824.5631577631;5841.620294680833;5869.442402971711;5873.970630146822;5922.1412895130825;5939.198208241832;5944.078667806497;5957.3446920837805;5960.344362120163;5605.719714014202;5663.263775709132;5732.684702341411;5786.3056433228285;5805.680687562056;5686.389142894374;5718.25662663851;5721.685307308138;5723.7996670116345;5727.36998930109;5948.631814682561;5951.226340575698;5956.54064754138;5963.224780778471;5973.1338955852025;3844.942325865058;4068.6338229559483;4070.2266569351727;4082.693797965105;4088.4889388826396;5500.9174862377895;5685.772569097356;5739.7417116229035;5758.913616295843;5776.306843178845;5461.208124821958;5659.320881494247;5659.518940890071;5661.4240520562225;5689.260396148474;5571.415001424954;5574.386817449996;5587.184165146263;5650.547956163415;5677.971610141923;5160.380754309507;5462.481064298885;5498.477644623755;5507.017473709541;5535.612507124462;5538.559974406764;5560.5829562783765;5623.803166889139;5641.492265696107;5649.604527683187;5523.171524271231;5557.554316323905;5576.944230557642;5616.213730077874;5650.717464126695 14:49:18 INFO - PROCESS | 364 | |5;yui.html;717.501336571083;724.1961422820672;798.4929569723224;819.9016118065833;857.5112186053948;14104.929475352621;15145.469908553203;15146.924265378657;15149;15189.088654680727;13993.300334983262;14161.71676566468;14191;14250.358733856976;14414.711705765878;669.4209508774924;797.3063434811722;797.9601019949008;811.1280373598405;826.0046643794213;812.0580127052621;816.9591520423985;818.9467684600481;819.6639377855081;820.0446479850966;853.3898262742138;853.5007020892785;854.8803167556547;855.5380094748829;855.6064210463195;705.6683358821346;799.6281728996045;820.4420993724265;821.6384790692076;851.1318455175717;606.287612055837;610.3987572241339;610.5787006965224;610.8686632374016;610.9083637454418;13973.09174903628;13997.650058748512;14006.089604175697;14021.158730476203;14035.368408421646;12873.356332183446;13217.140885842486;13743.862561374359;14007.439702411892;14058.367373468218;12497.25016499013;12499.500019999188;12555.246685198917;12561.748765024648;12625.558105466265;4232.957670423318;4239.236937351276;4296.763677997709;4314.611684948339;4327.0913108247305;55414;55586.72206638981;55631.721841390936;56029.71985140089;56158.43841561614;10340.844887326695;10466.21503387249;10570.365778053341;10593.205509586813;10729.678109656723;19835.50411239702;19990.100445479988;20064.297749578694;20088.89955550213;20109.798902011084;7791.181925897812;7834.138244793068;7925.8811117833275;8051.2351326623875;8070.394720395994;4411.4926783420315;4451.287793952952;4526.185286648435;4537.977310113428;4665.766711664471;3317.1872891141825;3378;3403.3193361327835;3410.0963244740165;3413.9487907681405;591.4174538079988;595.1637948682109;599.691159053088;604.2054698072021;612.8192183305936;627.959182653126;655.2824657000576;703.6235613946617;734.3537686835657;736.3593673503979;8759.649614015496;8846.601902914384;8981.281497480186;9314.72055838326;9348.252139828797;704.8167476456056;711.2567367101392;720.9639518024078;726.8727972604773;729.7336472187613;4150.896227594334;4322.6325762309925;4406.581374769392;4479.115748730551;4532.6827122101795;64796.35203647903;65201.347986519526;66102.66948665226;66686.33313666898;67512;41495;42077.579224207366;52992.470075298756;57115.71442142763;61714.382856170865;53073.93852122936;54058;54671.45328546664;54697.72651136798;55528;7761.72833950809;8044.798880028046;8226.465279756796;8249.133840946613;8368.41421100517;35285;35619.10952226215;35851.64148358483;36286.818565907;36461.817690911375;43245.78377108094;45674.54325456836;46387.304190436495;48096.7595162022;49302.26046609232;12735.745285094432;12864.099513033998;12900.935495322463;12947.611571652866;13237.073404861567;13805.516806912112;14063.578092657237;14256.42974281017;14482.275886205436;14850.995115659247;12905.548305809252;13270.601881943558;13464.93267533656;13518.391672374963;13659.931700341434;12637.93681031589;13157.473701051851;13613.828085683155;13899.264851976872;14202.869569564647;13102;13256.734865302833;13310.800337994744;13316.134451260637;13376.488634502113;9856.704298871045;9915.900840991499;10231.28381013322;10432.061114499731;10434.739131521772;10931.070858977077;10996.450177490933;11081.27971681838;11345.602903898323;11445.25605835618 14:49:18 INFO - PROCESS | 364 | __end_tp_report 14:49:18 INFO - PROCESS | 364 | __start_cc_report 14:49:18 INFO - PROCESS | 364 | _x_x_mozilla_cycle_collect,854 14:49:18 INFO - PROCESS | 364 | __end_cc_report 14:49:18 INFO - PROCESS | 364 | __startTimestamp1464817758466__endTimestamp 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | ------- Summary: start ------- 14:49:18 INFO - PROCESS | 364 | Number of tests: 6 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#0] dojo.html Cycles:165 Average:5406.82 Median:5602.58 stddev:614.89 (11.0%) stddev-sans-first:590.67 14:49:18 INFO - PROCESS | 364 | Values: 3147.2 3157.5 3171.9 3200.6 3213.2 5243.1 5288.0 5388.6 5496.1 5518.2 5386.2 5429.9 5439.8 5441.2 5490.8 4855.4 4895.4 4947.1 4959.8 5074.5 4973.9 4996.8 5028.1 5052.3 5055.5 4762.0 4799.0 4815.1 4871.2 4888.4 4860.2 4887.9 4948.5 4965.7 4996.9 4744.9 4914.4 4931.5 4932.7 4951.8 5256.9 5317.5 5323.7 5396.4 5419.8 5875.8 5876.1 5895.1 5901.7 5906.7 5740.0 5778.1 5785.0 5925.1 5975.5 5470.5 5486.6 5494.5 5501.9 5509.0 5970.7 6009.5 6037.9 6038.8 6040.8 5613.8 5696.9 5728.9 5745.4 5767.8 5874.9 5877.7 5924.6 5928.3 5932.8 5844.9 5857.4 5859.9 5862.9 5864.5 5635.6 5734.5 5793.3 5799.6 5845.4 4464.0 4464.6 4469.5 4469.9 4507.2 3900.2 3948.2 3994.3 4013.6 4044.0 5490.5 5569.1 5599.0 5632.0 5643.7 5881.2 5884.6 5893.9 5894.9 5944.9 5330.6 5480.7 5563.9 5570.9 5582.9 5036.5 5046.2 5086.2 5086.8 5124.5 6067.5 6073.5 6075.6 6082.0 6083.8 5589.0 5647.9 5663.2 5870.3 5884.1 5874.0 5889.7 5910.4 5923.0 5932.4 5532.2 5562.3 5566.7 5573.9 5577.6 5626.7 5712.7 5752.8 5767.5 5818.1 5724.5 5724.7 5725.4 5729.6 5731.1 5652.7 5686.1 5700.3 5713.4 5720.2 5424.2 5558.7 5602.6 5621.6 5661.9 5776.5 5791.5 5830.4 5843.5 5850.0 5496.6 5614.7 5660.2 5667.0 5697.1 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#1] ext.html Cycles:180 Average:59746.42 Median:44867.55 stddev:118006.30 (263.0%) stddev-sans-first:118253.74 14:49:18 INFO - PROCESS | 364 | Values: 587.4 619.7 632.4 634.7 645.1 30765.7 31527.7 43506.1 44368.8 44401.3 41883.2 45625.3 45632.8 45659.5 45685.8 8694.3 8900.2 8904.8 8905.3 8911.5 8557.9 8631.6 8677.9 8678.6 8698.0 8754.4 8761.6 8794.8 8797.0 8799.6 8721.3 8766.2 8768.8 8770.6 8778.5 8709.9 8829.2 8829.6 8835.0 8835.5 42202.0 42729.8 42793.6 42807.6 42890.4 3790.2 4000.9 4186.0 4283.7 4324.9 33165.5 33449.2 33467.0 33605.7 33984.0 4262.6 4281.4 4320.5 4412.0 4454.7 246919.0 248648.0 248757.8 249568.0 249898.0 59244.1 59298.4 59710.7 59746.0 59756.0 56897.7 61356.7 62586.7 62778.4 64439.4 16586.3 16839.7 16840.7 16851.1 16861.7 12698.9 12792.2 12866.8 12884.7 12897.0 15864.6 16907.7 17014.5 17093.4 17155.6 6446.9 6623.8 6670.0 6800.0 6903.1 922.2 961.2 1091.3 1122.0 1139.2 32226.7 32478.8 32601.7 32863.8 32998.2 1114.8 1163.6 1164.4 1187.8 1206.2 17406.8 18222.4 18305.5 19104.5 19149.3 539678.0 541450.0 545239.0 545376.0 547067.0 60514.0 60995.7 61016.4 61023.7 61139.4 1352.9 1390.7 1403.5 1417.6 1419.8 32777.5 33767.2 33907.8 34150.0 34197.9 52935.5 52956.5 53105.5 53315.5 53398.2 479207.0 481670.0 483852.0 484221.0 485472.0 25092.5 27071.6 27370.7 27664.7 28093.2 47536.5 48097.5 48549.8 54120.2 54937.5 42402.4 44930.3 45568.4 45847.5 47495.5 44804.8 44940.0 45141.0 45157.5 45667.8 45656.3 46523.0 47213.1 47271.5 47351.8 38615.6 40404.4 40549.2 40667.5 40744.4 29824.4 30383.0 30781.0 30851.5 31079.2 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#2] jquery.html Cycles:180 Average:29824.49 Median:13015.31 stddev:83799.71 (643.9%) stddev-sans-first:84005.65 14:49:18 INFO - PROCESS | 364 | Values: 393.9 399.7 401.1 402.1 425.7 13650.8 18080.2 19378.9 19384.1 20584.1 15511.7 17276.2 17927.1 18520.2 19522.9 5649.4 5853.9 5862.9 5889.9 5902.2 5700.9 5739.7 5739.8 5755.5 5819.5 4217.9 6192.8 6465.6 6489.9 6592.4 6453.6 6502.3 6529.3 6574.0 6583.0 5631.8 5692.4 5747.1 5769.6 5769.9 21975.8 22356.4 22762.3 23489.2 23603.2 2244.5 2246.2 2326.9 2427.5 2444.4 9676.6 13395.5 14496.5 14835.6 15159.2 1900.1 1958.8 1991.4 2016.5 2045.4 82411.6 83053.6 84864.0 86451.0 86780.0 11148.7 11156.7 11184.7 11236.6 11260.7 15340.5 15599.1 15667.5 15688.1 15709.0 8262.4 8362.1 8396.5 8483.7 8484.5 8026.8 8030.6 8050.0 8146.7 8230.4 4512.7 4640.4 4661.8 4833.8 4936.0 1950.7 2005.3 2006.8 2024.8 2061.5 916.4 955.8 1038.8 1060.4 1083.9 19242.3 19592.3 19625.0 19674.5 19694.0 999.1 1001.3 1035.6 1072.1 1088.4 10792.4 11191.6 11196.8 11200.1 11246.6 495091.7 498065.0 499736.0 522542.0 524507.0 90537.0 93831.5 95771.5 97062.0 97581.5 891.3 936.1 1054.6 1077.6 1080.5 16964.7 17020.5 17119.3 17453.3 17795.5 38355.0 40762.0 42188.7 42207.4 42519.8 58241.7 59094.1 59663.0 59891.4 60540.4 8570.1 8702.3 8798.6 8811.9 9004.3 9409.3 12801.2 13357.8 13449.7 13481.9 11441.3 11508.8 11580.1 11697.5 11961.3 11632.7 11804.7 11809.3 11929.5 12046.2 11808.4 12014.8 12142.1 12248.4 12270.6 8566.0 8608.9 8653.9 8807.3 8908.7 11036.3 11924.9 11980.6 12035.6 12318.9 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#3] mootools.html Cycles:180 Average:5989.06 Median:4035.15 stddev:3444.68 (85.4%) stddev-sans-first:3436.52 14:49:18 INFO - PROCESS | 364 | Values: 1326.0 1454.9 1525.5 1643.5 1821.2 8608.0 8962.7 9009.1 9238.0 9243.0 8972.6 9116.1 9163.0 9178.5 9192.0 2104.8 2303.2 2346.7 2383.8 2387.5 2404.5 2412.9 2413.8 2414.3 2415.7 2369.7 2389.3 2419.3 2421.8 2422.3 2019.3 2289.9 2342.6 2361.9 2365.1 2352.0 2369.9 2394.4 2395.0 2395.8 9041.9 9070.2 9126.4 9129.8 9136.5 5107.4 5240.7 5246.1 5247.2 5249.0 3124.9 3286.6 3297.1 3378.5 3389.5 1074.0 1099.8 1123.8 1140.0 1142.1 12584.7 12620.0 12623.1 12626.4 12633.4 4765.8 4816.9 4836.5 4843.6 4874.0 10571.4 10597.2 10602.4 10603.8 10612.9 5486.9 5501.5 5501.9 5502.8 5505.2 4370.1 4869.9 5000.4 5010.8 5062.2 3863.7 4008.0 4023.6 4079.2 4095.2 1306.6 1310.4 1312.3 1325.4 1326.5 854.5 1008.3 1020.2 1034.2 1035.6 6212.8 6292.4 6317.2 6453.7 6480.9 1022.9 1048.3 1053.5 1083.6 1116.0 3946.2 3977.2 3987.6 4000.7 4046.7 11138.4 11376.3 11468.8 11549.5 11557.4 11209.6 11291.4 11299.3 11341.0 11345.9 8110.2 8399.3 8419.6 8443.3 8582.7 6079.2 6164.5 6216.2 6222.0 6246.1 10285.2 10583.1 10775.4 10802.0 10806.6 10791.9 10973.6 10996.6 11008.2 11113.4 7451.2 7749.8 7945.4 8047.8 8190.2 8746.1 8753.0 8832.2 8837.4 8840.6 7728.4 7793.5 7800.8 7914.3 8167.6 7583.2 7764.9 7898.3 7977.8 8026.3 7122.3 7278.0 7390.9 7393.4 7397.9 5206.6 5312.5 5338.6 5350.4 5433.3 5174.1 5181.5 5235.6 5434.6 5466.8 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#4] prototype.html Cycles:180 Average:4635.23 Median:5152.04 stddev:1375.85 (26.7%) stddev-sans-first:1341.04 14:49:18 INFO - PROCESS | 364 | Values: 319.7 329.4 333.7 336.5 339.7 5143.7 5274.2 5324.8 5373.4 5393.0 5258.0 5317.5 5319.2 5322.0 5340.4 4112.9 4143.5 4169.4 4172.3 4198.1 3906.9 3969.8 4065.6 4182.3 4197.4 4016.9 4043.5 4127.9 4146.3 4152.5 4053.5 4072.3 4099.8 4117.5 4117.7 3417.6 3653.9 3672.5 3672.9 3682.8 5054.1 5087.5 5088.2 5098.3 5102.2 4716.9 4728.6 4741.0 4742.7 4751.0 5411.6 5506.6 5547.5 5554.9 5563.0 3933.9 3943.9 3944.9 3951.8 3976.9 5661.5 5683.4 5700.3 5700.7 5766.7 3895.6 3993.6 4031.8 4046.9 4053.0 4028.2 4040.2 4042.2 4049.3 4055.3 4614.8 4616.6 4620.6 4623.4 4651.7 5485.4 5492.0 5504.8 5511.7 5512.5 1291.6 1390.8 1418.3 1418.8 1419.4 882.2 910.2 910.2 915.3 921.5 4751.8 4800.1 4823.0 4855.4 4869.9 5036.4 5046.5 5055.6 5076.9 5126.4 4757.8 4769.6 4833.5 4872.0 5044.5 3017.5 3026.2 3043.2 3058.4 3069.4 5885.9 5904.1 5913.6 5916.4 5934.3 5648.5 5824.6 5841.6 5869.4 5874.0 5922.1 5939.2 5944.1 5957.3 5960.3 5605.7 5663.3 5732.7 5786.3 5805.7 5686.4 5718.3 5721.7 5723.8 5727.4 5948.6 5951.2 5956.5 5963.2 5973.1 3844.9 4068.6 4070.2 4082.7 4088.5 5500.9 5685.8 5739.7 5758.9 5776.3 5461.2 5659.3 5659.5 5661.4 5689.3 5571.4 5574.4 5587.2 5650.5 5678.0 5160.4 5462.5 5498.5 5507.0 5535.6 5538.6 5560.6 5623.8 5641.5 5649.6 5523.2 5557.6 5576.9 5616.2 5650.7 14:49:18 INFO - PROCESS | 364 | 14:49:18 INFO - PROCESS | 364 | [#5] yui.html Cycles:180 Average:15184.13 Median:4465.20 stddev:17661.62 (395.5%) stddev-sans-first:17677.75 14:49:18 INFO - PROCESS | 364 | Values: 717.5 724.2 798.5 819.9 857.5 14104.9 15145.5 15146.9 15149.0 15189.1 13993.3 14161.7 14191.0 14250.4 14414.7 669.4 797.3 798.0 811.1 826.0 812.1 817.0 818.9 819.7 820.0 853.4 853.5 854.9 855.5 855.6 705.7 799.6 820.4 821.6 851.1 606.3 610.4 610.6 610.9 610.9 13973.1 13997.7 14006.1 14021.2 14035.4 12873.4 13217.1 13743.9 14007.4 14058.4 12497.3 12499.5 12555.2 12561.7 12625.6 4233.0 4239.2 4296.8 4314.6 4327.1 55414.0 55586.7 55631.7 56029.7 56158.4 10340.8 10466.2 10570.4 10593.2 10729.7 19835.5 19990.1 20064.3 20088.9 20109.8 7791.2 7834.1 7925.9 8051.2 8070.4 4411.5 4451.3 4526.2 4538.0 4665.8 3317.2 3378.0 3403.3 3410.1 3413.9 591.4 595.2 599.7 604.2 612.8 628.0 655.3 703.6 734.4 736.4 8759.6 8846.6 8981.3 9314.7 9348.3 704.8 711.3 721.0 726.9 729.7 4150.9 4322.6 4406.6 4479.1 4532.7 64796.4 65201.3 66102.7 66686.3 67512.0 41495.0 42077.6 52992.5 57115.7 61714.4 53073.9 54058.0 54671.5 54697.7 55528.0 7761.7 8044.8 8226.5 8249.1 8368.4 35285.0 35619.1 35851.6 36286.8 36461.8 43245.8 45674.5 46387.3 48096.8 49302.3 12735.7 12864.1 12900.9 12947.6 13237.1 13805.5 14063.6 14256.4 14482.3 14851.0 12905.5 13270.6 13464.9 13518.4 13659.9 12637.9 13157.5 13613.8 13899.3 14202.9 13102.0 13256.7 13310.8 13316.1 13376.5 9856.7 9915.9 10231.3 10432.1 10434.7 10931.1 10996.5 11081.3 11345.6 11445.3 14:49:18 INFO - PROCESS | 364 | -------- Summary: end -------- 14:49:18 INFO - PROCESS | 364 | 14:49:19 INFO - TEST-INFO | 364: exit 0 14:49:19 INFO - TEST-OK | dromaeo_css | took 1112713ms 14:49:19 INFO - TEST-START | kraken 14:49:19 INFO - operating with platform_type : linux_ 14:49:19 INFO - Initialising browser for kraken test... 14:49:19 INFO - TEST-INFO | started process 550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqOxDS/profile http://localhost:47010/getInfo.html) 14:49:23 INFO - PROCESS | 550 | __metrics Screen width/height:1600/1200 14:49:23 INFO - PROCESS | 550 | colorDepth:24 14:49:23 INFO - PROCESS | 550 | Browser inner width/height: 1024/697 14:49:23 INFO - PROCESS | 550 | __metrics 14:49:24 ERROR - PROCESS | 550 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:49:24 INFO - TEST-INFO | 550: exit 0 14:49:24 INFO - Browser initialized. 14:49:24 INFO - Running cycle 1/1 for kraken test... 14:49:24 INFO - TEST-INFO | started process 636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqOxDS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:36 INFO - PROCESS | 636 | RSS: Main: 156012544 14:49:36 INFO - PROCESS | 636 | 14:49:39 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47010/tests/kraken/driver.html?testName=audio-beat-detection) 14:49:40 INFO - PROCESS | 636 | RSS: Main: 214089728 14:49:40 INFO - PROCESS | 636 | 14:49:42 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47010/tests/kraken/driver.html?testName=audio-dft) 14:49:43 INFO - PROCESS | 636 | RSS: Main: 202113024 14:49:43 INFO - PROCESS | 636 | 14:49:46 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47010/tests/kraken/driver.html?testName=audio-fft) 14:49:47 INFO - PROCESS | 636 | RSS: Main: 268312576 14:49:47 INFO - PROCESS | 636 | 14:49:49 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47010/tests/kraken/driver.html?testName=audio-oscillator) 14:49:49 INFO - PROCESS | 636 | RSS: Main: 179748864 14:49:49 INFO - PROCESS | 636 | 14:49:51 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:49:52 INFO - PROCESS | 636 | RSS: Main: 183107584 14:49:52 INFO - PROCESS | 636 | 14:49:55 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47010/tests/kraken/driver.html?testName=imaging-darkroom) 14:49:56 INFO - PROCESS | 636 | RSS: Main: 217878528 14:49:56 INFO - PROCESS | 636 | 14:49:59 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47010/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:00 INFO - PROCESS | 636 | RSS: Main: 220422144 14:50:00 INFO - PROCESS | 636 | 14:50:02 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47010/tests/kraken/driver.html?testName=json-parse-financial) 14:50:03 INFO - PROCESS | 636 | RSS: Main: 220360704 14:50:03 INFO - PROCESS | 636 | 14:50:05 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:05 INFO - PROCESS | 636 | RSS: Main: 208572416 14:50:05 INFO - PROCESS | 636 | 14:50:07 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:07 INFO - PROCESS | 636 | RSS: Main: 211910656 14:50:07 INFO - PROCESS | 636 | 14:50:10 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:10 INFO - PROCESS | 636 | RSS: Main: 216956928 14:50:10 INFO - PROCESS | 636 | 14:50:13 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:13 INFO - PROCESS | 636 | RSS: Main: 222195712 14:50:13 INFO - PROCESS | 636 | 14:50:16 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:17 INFO - PROCESS | 636 | RSS: Main: 221810688 14:50:17 INFO - PROCESS | 636 | 14:50:18 INFO - PROCESS | 636 | Cycle 1(1): loaded http://localhost:47010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47010/tests/kraken/driver.html?testName=ai-astar) 14:50:19 INFO - PROCESS | 636 | RSS: Main: 264589312 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | __start_tp_report 14:50:19 INFO - PROCESS | 636 | _x_x_mozilla_page_load 14:50:19 INFO - PROCESS | 636 | _x_x_mozilla_page_load_details 14:50:19 INFO - PROCESS | 636 | |i|pagename|runs| 14:50:19 INFO - PROCESS | 636 | |0;ai-astar;109;103;109;109;108;109;111;108;109;109 14:50:19 INFO - PROCESS | 636 | |1;audio-beat-detection;160;124;129;187;124;134;161;126;185;134 14:50:19 INFO - PROCESS | 636 | |2;audio-dft;162;163;160;161;162;162;162;162;161;162 14:50:19 INFO - PROCESS | 636 | |3;audio-fft;75;75;76;127;73;74;75;74;97;75 14:50:19 INFO - PROCESS | 636 | |4;audio-oscillator;83;84;109;83;84;84;126;84;83;131 14:50:19 INFO - PROCESS | 636 | |5;imaging-gaussian-blur;117;116;118;117;117;116;117;117;117;117 14:50:19 INFO - PROCESS | 636 | |6;imaging-darkroom;146;145;146;146;147;145;145;145;146;146 14:50:19 INFO - PROCESS | 636 | |7;imaging-desaturate;95;95;96;94;95;96;94;95;95;96 14:50:19 INFO - PROCESS | 636 | |8;json-parse-financial;54;53;52;53;55;54;52;53;52;53 14:50:19 INFO - PROCESS | 636 | |9;json-stringify-tinderbox;62;61;62;62;62;63;63;62;63;62 14:50:19 INFO - PROCESS | 636 | |10;stanford-crypto-aes;84;82;80;79;80;81;83;81;109;80 14:50:19 INFO - PROCESS | 636 | |11;stanford-crypto-ccm;130;123;120;125;117;117;118;120;126;120 14:50:19 INFO - PROCESS | 636 | |12;stanford-crypto-pbkdf2;160;160;165;163;160;157;157;162;157;158 14:50:19 INFO - PROCESS | 636 | |13;stanford-crypto-sha256-iterative;63;64;66;62;66;62;61;61;65;60 14:50:19 INFO - PROCESS | 636 | __end_tp_report 14:50:19 INFO - PROCESS | 636 | __start_cc_report 14:50:19 INFO - PROCESS | 636 | _x_x_mozilla_cycle_collect,1646 14:50:19 INFO - PROCESS | 636 | __end_cc_report 14:50:19 INFO - PROCESS | 636 | __startTimestamp1464817819081__endTimestamp 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | ------- Summary: start ------- 14:50:19 INFO - PROCESS | 636 | Number of tests: 14 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:2.07 (1.9%) stddev-sans-first:2.18 14:50:19 INFO - PROCESS | 636 | Values: 109.0 103.0 109.0 109.0 108.0 109.0 111.0 108.0 109.0 109.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:147.00 stddev:24.87 (16.9%) stddev-sans-first:25.89 14:50:19 INFO - PROCESS | 636 | Values: 160.0 124.0 129.0 187.0 124.0 134.0 161.0 126.0 185.0 134.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 14:50:19 INFO - PROCESS | 636 | Values: 162.0 163.0 160.0 161.0 162.0 162.0 162.0 162.0 161.0 162.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:17.29 (23.1%) stddev-sans-first:18.15 14:50:19 INFO - PROCESS | 636 | Values: 75.0 75.0 76.0 127.0 73.0 74.0 75.0 74.0 97.0 75.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.50 stddev:19.35 (23.2%) stddev-sans-first:20.02 14:50:19 INFO - PROCESS | 636 | Values: 83.0 84.0 109.0 83.0 84.0 84.0 126.0 84.0 83.0 131.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:50:19 INFO - PROCESS | 636 | Values: 117.0 116.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:50:19 INFO - PROCESS | 636 | Values: 146.0 145.0 146.0 146.0 147.0 145.0 145.0 145.0 146.0 146.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:50:19 INFO - PROCESS | 636 | Values: 95.0 95.0 96.0 94.0 95.0 96.0 94.0 95.0 95.0 96.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 14:50:19 INFO - PROCESS | 636 | Values: 54.0 53.0 52.0 53.0 55.0 54.0 52.0 53.0 52.0 53.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:50:19 INFO - PROCESS | 636 | Values: 62.0 61.0 62.0 62.0 62.0 63.0 63.0 62.0 63.0 62.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:8.95 (11.0%) stddev-sans-first:9.49 14:50:19 INFO - PROCESS | 636 | Values: 84.0 82.0 80.0 79.0 80.0 81.0 83.0 81.0 109.0 80.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:4.30 (3.5%) stddev-sans-first:3.32 14:50:19 INFO - PROCESS | 636 | Values: 130.0 123.0 120.0 125.0 117.0 117.0 118.0 120.0 126.0 120.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:2.77 (1.7%) stddev-sans-first:2.93 14:50:19 INFO - PROCESS | 636 | Values: 160.0 160.0 165.0 163.0 160.0 157.0 157.0 162.0 157.0 158.0 14:50:19 INFO - PROCESS | 636 | 14:50:19 INFO - PROCESS | 636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.16 (3.4%) stddev-sans-first:2.29 14:50:19 INFO - PROCESS | 636 | Values: 63.0 64.0 66.0 62.0 66.0 62.0 61.0 61.0 65.0 60.0 14:50:19 INFO - PROCESS | 636 | -------- Summary: end -------- 14:50:19 INFO - PROCESS | 636 | 14:50:20 INFO - TEST-INFO | 636: exit 0 14:50:20 INFO - TEST-OK | kraken | took 61023ms 14:50:20 INFO - SUITE-END | took 1173s 14:50:20 INFO - Completed test suite (00:19:33) 14:50:20 INFO - javascript benchmark 14:50:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.213196700825, 3157.5421563873224, 3171.8572664230105, 3200.5999250093737, 3213.1645772099246, 5243.10867152584, 5288.0, 5388.622796404248, 5496.148097044959, 5518.1998610201545, 5386.245925570413, 5429.945700542993, 5439.755211015504, 5441.183822426638, 5490.752916118774, 4855.417349918015, 4895.412550493946, 4947.109520286347, 4959.752012399384, 5074.4925507449325, 4973.875653108683, 4996.77514511846, 5028.120078986181, 5052.343195384613, 5055.545000949914, 4761.976190119045, 4798.976005119987, 4815.109204797123, 4871.196252618313, 4888.41339039314, 4860.198067318888, 4887.926681099786, 4948.455669876311, 4965.702057876539, 4996.925046124311, 4744.905101897943, 4914.410270767531, 4931.457539670633, 4932.7040377577105, 4951.752412379403, 5256.894862102775, 5317.494837990384, 5323.680579165262, 5396.379416367129, 5419.783208671648, 5875.794347197871, 5876.1479585459865, 5895.115732640095, 5901.675407852566, 5906.704664766745, 5740.024195886709, 5778.075507918755, 5785.045467497858, 5925.051991681354, 5975.492083172936, 5470.480304371078, 5486.561075113981, 5494.450554944514, 5501.944980550184, 5508.9724551376985, 5970.701464926737, 6009.549283803733, 6037.909431358533, 6038.788642397495, 6040.848978775478, 5613.775448982076, 5696.914546281809, 5728.856778580485, 5745.425457454221, 5767.798127065533, 5874.94125058744, 5877.676727780014, 5924.644521328734, 5928.318243402064, 5932.762689492372, 5844.88310233793, 5857.414258574194, 5859.853503662357, 5862.912056319158, 5864.501517371071, 5635.605507614509, 5734.541236701054, 5793.275840519935, 5799.565032622486, 5845.444682755132, 4464.0402313502755, 4464.620507256919, 4469.5306992765945, 4469.865904022885, 4507.188706032945, 3900.2004589059175, 3948.190620922704, 3994.320965435883, 4013.618706222904, 4044.029432936133, 5490.533304669068, 5569.10894256917, 5599.048161812501, 5632.0, 5643.689597072201, 5881.206037185011, 5884.588078834526, 5893.852653683693, 5894.8821023579285, 5944.910826337608, 5330.600204984564, 5480.725963701799, 5563.944360556424, 5570.888582228414, 5582.944170558242, 5036.546710796046, 5046.243063540425, 5086.21163719624, 5086.796528138833, 5124.5131712487255, 6067.484263837535, 6073.51411887048, 6075.574709770273, 6081.969590152021, 6083.756649733961, 5589.0, 5647.943520564906, 5663.150527420919, 5870.295564532284, 5884.117382392676, 5874.0, 5889.67606781614, 5910.408959104056, 5923.022701254417, 5932.436418540232, 5532.197831314356, 5562.332520097614, 5566.749496272597, 5573.888522229614, 5577.581681373832, 5626.690532020778, 5712.714364281853, 5752.798652047159, 5767.5385969121535, 5818.127280907897, 5724.542036637143, 5724.713764311685, 5725.370209276893, 5729.570282228766, 5731.054376027909, 5652.745626446737, 5686.118651609007, 5700.315962084576, 5713.371529131875, 5720.199172115824, 5424.24060631504, 5558.749856256397, 5602.579806514446, 5621.634593751393, 5661.85845353853, 5776.537876969916, 5791.478766910998, 5830.416958304136, 5843.474087332161, 5850.0, 5496.587755918242, 5614.7192640367, 5660.235868157746, 5667.03660377745, 5697.145428185805], "value": 5365.5778090583435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3685787778139, 619.7180282971248, 632.3644737039275, 634.663628277013, 645.0968643898544, 30765.692343076564, 31527.68472315276, 43506.12987740247, 44368.778156109256, 44401.333979990326, 41883.162336753245, 45625.31562026572, 45632.771836140855, 45659.54340456594, 45685.771571142184, 8694.304455643565, 8900.243479304267, 8904.821903561924, 8905.287576993825, 8911.465312081296, 8557.871631925525, 8631.568421578895, 8677.913220867773, 8678.609462574168, 8698.0, 8754.430961987451, 8761.605727742235, 8794.780130496725, 8796.956015219916, 8799.604017819214, 8721.30229581632, 8766.211041006309, 8768.824623507495, 8770.605322760492, 8778.47329160246, 8709.869351959662, 8829.161229683234, 8829.646814127427, 8834.955825220834, 8835.469871807647, 42202.0, 42729.78635106836, 42793.57206427927, 42807.57192428067, 42890.356644650354, 3790.2419516096893, 4000.899977500557, 4185.958140418587, 4283.721558098714, 4324.891877703082, 33165.50251746202, 33449.16377090568, 33467.0, 33605.6639433605, 33984.0, 4262.595053469915, 4281.400603915455, 4320.503142138631, 4411.977940110311, 4454.732716037048, 246919.0, 248648.0, 248757.7562112196, 249568.0, 249898.0, 59244.11133832996, 59298.40701593015, 59710.70144649249, 59746.0, 59756.0, 56897.715511423005, 61356.69321653363, 62586.68706656437, 62778.372216277254, 64439.355606444275, 16586.336546538005, 16839.66320673604, 16840.663186736198, 16851.07319097437, 16861.662766744597, 12698.936505317415, 12792.232466052066, 12866.806997895039, 12884.677883052998, 12897.0, 15864.603384915239, 16907.661846763243, 17014.48956531306, 17093.401730939608, 17155.571110722332, 6446.935530644727, 6623.801285961429, 6669.966650166815, 6799.966000170067, 6903.1371078615175, 922.1884741427635, 961.2310151878469, 1091.328832767842, 1122.0462606784167, 1139.2082502660571, 32226.677733222838, 32478.837605812292, 32601.673983260338, 32863.835680821445, 32998.19515341175, 1114.765899161169, 1163.5636636261402, 1164.3654208456412, 1187.8396416483663, 1206.203905422417, 17406.825931740776, 18222.36221732233, 18305.450836474927, 19104.52238694016, 19149.329773457863, 539678.0, 541450.0, 545239.0, 545376.0, 547067.0, 60514.0, 60995.6950215255, 61016.38983610107, 61023.694881525305, 61139.38860611426, 1352.8579499152645, 1390.65928847431, 1403.5087719298165, 1417.6101572067764, 1419.836718777333, 32777.50833737544, 33767.15582110467, 33907.83046084754, 34150.0, 34197.852342335245, 52935.4706452946, 52956.47043529515, 53105.4689453116, 53315.4668453326, 53398.199027015406, 479207.0, 481670.0, 483852.0, 484221.0, 485472.0, 25092.498150036532, 27071.59392609073, 27370.726292736817, 27664.723352766214, 28093.157205283875, 47536.52463475459, 48097.5190248107, 48549.757251213516, 54120.188197176285, 54937.450625493235, 42402.36396453994, 44930.3260451087, 45568.41905484975, 45847.541524585664, 47495.525044750495, 44804.77597611991, 44940.0, 45141.0, 45157.548424515335, 45667.77166114148, 45656.31515527203, 46523.0, 47213.05573888572, 47271.52728472671, 47351.76324118357, 38615.6138438612, 40404.35349934795, 40549.18901621892, 40667.478392781864, 40744.388834166915, 29824.403511930075, 30383.0, 30781.0, 30851.537226941164, 31079.223019424695], "value": 20449.45103634909, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.93106206413887, 399.65629558579633, 401.08952677422235, 402.12537730436304, 425.67826897483314, 13650.841506883286, 18080.186391612377, 19378.90310548447, 19384.127714252856, 20584.07371668275, 15511.689766204669, 17276.22256998435, 17927.10364481774, 18520.166592503338, 19522.902385488087, 5649.406812284702, 5853.941460585383, 5862.88274234515, 5889.85275368115, 5902.232709747726, 5700.857478563048, 5739.655620662753, 5739.827805165852, 5755.453231942959, 5819.476247137757, 4217.873463796076, 6192.78325258616, 6465.644389558573, 6489.935100648981, 6592.406683398517, 6453.580517266362, 6502.349765023483, 6529.281779004329, 6573.967130164342, 6583.045458408504, 5631.774729010835, 5692.37383887772, 5747.109198074305, 5769.624974376652, 5769.855753606152, 21975.780242197532, 22356.441088972744, 22762.317130486113, 23489.17787877433, 23603.173888913978, 2244.517428752826, 2246.2475070851283, 2326.941826454335, 2427.453822889853, 2444.4499987502845, 9676.649327140209, 13395.531156409575, 14496.492622758258, 14835.554933352018, 15159.166245856473, 1900.0974537094908, 1958.8237058664788, 1991.442396129086, 2016.4958760309923, 2045.447729113146, 82411.5879420605, 83053.58473207595, 84864.0, 86451.0, 86780.0, 11148.65202570998, 11156.665300041012, 11184.664460066211, 11236.550537978554, 11260.662180134608, 15340.463083792014, 15599.064056156667, 15667.529974100795, 15688.137152456724, 15708.978916370399, 8262.380321475794, 8362.080171181287, 8396.454230475, 8483.660653573788, 8484.53335066565, 8026.799330016796, 8030.638621262057, 8049.959750201211, 8146.714864979697, 8230.42387032914, 4512.661550383735, 4640.350350950869, 4661.790219440133, 4833.830815921426, 4935.950640493549, 1950.7073938909277, 2005.31819181479, 2006.7692215395125, 2024.817766401031, 2061.4640193549785, 916.4363916191628, 955.7515046088067, 1038.7898098715063, 1060.4432672846817, 1083.9377410138109, 19242.326518571783, 19592.314269000515, 19625.0, 19674.50813729668, 19694.0, 999.0509016434416, 1001.3140998416109, 1035.5598870480017, 1072.0780129088978, 1088.3959402531514, 10792.406417647106, 11191.552337906556, 11196.776064478665, 11200.103991680646, 11246.550137994389, 495091.67179148557, 498065.0, 499736.0, 522542.0, 524507.0, 90537.0, 93831.53084234672, 95771.52114239385, 97062.02937970671, 97581.5120924405, 891.2736120062258, 936.0592604432638, 1054.6150655010865, 1077.6443773554709, 1080.5407701726735, 16964.660706786042, 17020.48938531846, 17119.315227390765, 17453.30186792514, 17795.46613601594, 38355.0, 40762.0, 42188.67962262105, 42207.366889496065, 42519.7874010628, 58241.70879145577, 59094.11358829535, 59663.0, 59891.40108599033, 60540.39459605348, 8570.100139485514, 8702.347323950855, 8798.648054077765, 8811.911880881109, 9004.32467564922, 9409.341346105706, 12801.167924084904, 13357.799633005317, 13449.731005380034, 13481.932590336986, 11441.256318339614, 11508.82736758966, 11580.131490138105, 11697.532098715956, 11961.342126183143, 11632.651020469399, 11804.70488237801, 11809.291442513477, 11929.463174157358, 12046.216995895238, 11808.350540720343, 12014.819777703517, 12142.089343299465, 12248.38758062111, 12270.570530031406, 8565.957170214358, 8608.870866936875, 8653.870191947, 8807.251383632463, 8908.688195913372, 11036.282641628268, 11924.880751192377, 11980.58067967617, 12035.638930832089, 12318.876811232132], "value": 9427.72995456943, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.044084974663, 1454.9378953364048, 1525.534711912867, 1643.457658972539, 1821.235081265869, 8607.956960215199, 8962.731118066453, 9009.054049324817, 9238.0, 9243.0, 8972.641094356219, 9116.133967273116, 9163.0, 9178.495182764946, 9192.0, 2104.7579528354204, 2303.239930822833, 2346.7418583955796, 2383.7735415135535, 2387.450886296153, 2404.5311164322966, 2412.915547955813, 2413.8310318277727, 2414.3239892829947, 2415.722191947922, 2369.7037870266217, 2389.2951579284154, 2419.2984034629935, 2421.8062554995645, 2422.2612103308484, 2019.3437132931856, 2289.8626082435107, 2342.601757701186, 2361.9055237790467, 2365.113082594027, 2351.988240058806, 2369.869657168855, 2394.449276666359, 2395.0, 2395.7843794058617, 9041.864372034424, 9070.18368346852, 9126.361154719172, 9129.771755706093, 9136.451812891248, 5107.438181799999, 5240.716024573966, 5246.134387826004, 5247.239150323182, 5248.9737551312, 3124.906252812419, 3286.6384697683234, 3297.142742886843, 3378.476336167898, 3389.474631432132, 1073.9946300268527, 1099.8185299425586, 1123.7640095579939, 1139.971500712489, 1142.1034487926938, 12584.74830503394, 12620.0, 12623.05327100462, 12626.431810568454, 12633.431495582721, 4765.753629696181, 4816.8554943351755, 4836.540528649843, 4843.588294994895, 4874.0, 10571.418571978615, 10597.20520960931, 10602.41686707223, 10603.84094238587, 10612.893871061346, 5486.945130548724, 5501.477359650907, 5501.889962200814, 5502.807401741, 5505.201745746845, 4370.147821174841, 4869.902601947942, 5000.374953130859, 5010.799568017312, 5062.164742817467, 3863.7102217333813, 4007.979960100239, 4023.637872591481, 4079.224947260011, 4095.1604920991126, 1306.6210798868412, 1310.4234136979699, 1312.2913626641698, 1325.357201757147, 1326.4561529772748, 854.5385491834339, 1008.294194064158, 1020.1940467031111, 1034.1881622925966, 1035.5909415780725, 6212.844678882973, 6292.370762923762, 6317.241930968313, 6453.741850325934, 6480.870382592416, 1022.8721409823772, 1048.2871647279771, 1053.5153829238636, 1083.5990683447176, 1115.983260251097, 3946.151577410813, 3977.2244412339314, 3987.641112299907, 4000.699947503949, 4046.6560342371226, 11138.387388693538, 11376.260543064674, 11468.770624587629, 11549.480273387719, 11557.422128893522, 11209.551617935354, 11291.435428228555, 11299.322040677585, 11341.0, 11345.886541134483, 8110.229528194812, 8399.286060684788, 8419.579021048923, 8443.28232100266, 8582.699605513777, 6079.179310792986, 6164.537659675452, 6216.222972128484, 6222.0, 6246.063090536456, 10285.177185825265, 10583.100436462986, 10775.353478791298, 10802.0, 10806.621768238074, 10791.946040269748, 10973.561057557608, 10996.615118470816, 11008.174386921173, 11113.44432778374, 7451.2117091898635, 7749.7675069748, 7945.443818932619, 8047.798805029921, 8190.221928916743, 8746.125387461203, 8753.037165911617, 8832.249258813074, 8837.381383303107, 8840.646374145219, 7728.420368472274, 7793.454458187873, 7800.804979875322, 7914.327282181079, 8167.632456539589, 7583.165851756192, 7764.88352674699, 7898.28915397594, 7977.840443190988, 8026.317762989977, 7122.287771222836, 7277.963610182127, 7390.9260907390235, 7393.445491588045, 7397.926020739724, 5206.609504287269, 5312.5218730314455, 5338.572914166935, 5350.384705758732, 5433.347998240079, 5174.068667639861, 5181.5077567631015, 5235.554977826775, 5434.64674796137, 5466.80866169698], "value": 4773.529720223429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.6531763037103, 329.38569567756133, 333.6763339560627, 336.517097964421, 339.6942751523627, 5143.691378517292, 5274.156135018397, 5324.813631522898, 5373.408925018245, 5392.9730351348235, 5258.027264955986, 5317.521423071923, 5319.228711836781, 5321.977648493567, 5340.412554618989, 4112.897177570562, 4143.461350024492, 4169.353750168729, 4172.290710579194, 4198.076423186909, 3906.9413958790497, 3969.7618142911374, 4065.6340929316357, 4182.33082706767, 4197.391378250152, 4016.9397459038137, 4043.5349934757587, 4127.938080928789, 4146.3365861462025, 4152.460180176573, 4053.5135783705996, 4072.287349713803, 4099.795010249476, 4117.485314335708, 4117.691173161995, 3417.5646228584055, 3653.872114476007, 3672.467492213641, 3672.889813305605, 3682.834272457719, 5054.1407960646775, 5087.465816089294, 5088.23676448532, 5098.286239926413, 5102.209157580581, 4716.905661886777, 4728.574428301469, 4740.976295118502, 4742.739149346785, 4750.952490475085, 5411.56707463402, 5506.64206826555, 5547.5007249347755, 5554.944450555483, 5563.026470367669, 3933.9213215735813, 3943.881683549498, 3944.861929832442, 3951.8024098794945, 3976.9005774855573, 5661.46216109469, 5683.374828768832, 5700.2589663343915, 5700.686462244575, 5766.740496677701, 3895.590962948906, 3993.600639935983, 4031.8185681644395, 4046.858359957387, 4053.0, 4028.234635419261, 4040.17176478827, 4042.2319759245647, 4049.311617025113, 4055.2903241932545, 4614.76926153691, 4616.6075883550275, 4620.636912110936, 4623.398958135488, 4651.674382793172, 5485.424030476823, 5491.9725401373535, 5504.80733174345, 5511.724413779295, 5512.531434828004, 1291.6125162451226, 1390.7983342415293, 1418.2625034981752, 1418.8294656907885, 1419.396082426851, 882.1839798186652, 910.1944778870615, 910.1944778870748, 915.2952226785338, 921.4977837078808, 4751.786169622375, 4800.1119792838435, 4822.9758851206225, 4855.417349918032, 4869.9269510957365, 5036.445990940993, 5046.511279172653, 5055.559165637776, 5076.923846142311, 5126.384833819965, 4757.785899634525, 4769.642276829182, 4833.477454601789, 4871.95128048715, 5044.470330615306, 3017.5171972484736, 3026.228311780482, 3043.193553708269, 3058.403611295776, 3069.355435358555, 5885.882282354414, 5904.08486684556, 5913.645181289136, 5916.437938395846, 5934.3175534814045, 5648.49163575272, 5824.5631577631, 5841.620294680833, 5869.442402971711, 5873.970630146822, 5922.1412895130825, 5939.198208241832, 5944.078667806497, 5957.3446920837805, 5960.344362120163, 5605.719714014202, 5663.263775709132, 5732.684702341411, 5786.3056433228285, 5805.680687562056, 5686.389142894374, 5718.25662663851, 5721.685307308138, 5723.7996670116345, 5727.36998930109, 5948.631814682561, 5951.226340575698, 5956.54064754138, 5963.224780778471, 5973.1338955852025, 3844.942325865058, 4068.6338229559483, 4070.2266569351727, 4082.693797965105, 4088.4889388826396, 5500.9174862377895, 5685.772569097356, 5739.7417116229035, 5758.913616295843, 5776.306843178845, 5461.208124821958, 5659.320881494247, 5659.518940890071, 5661.4240520562225, 5689.260396148474, 5571.415001424954, 5574.386817449996, 5587.184165146263, 5650.547956163415, 5677.971610141923, 5160.380754309507, 5462.481064298885, 5498.477644623755, 5507.017473709541, 5535.612507124462, 5538.559974406764, 5560.5829562783765, 5623.803166889139, 5641.492265696107, 5649.604527683187, 5523.171524271231, 5557.554316323905, 5576.944230557642, 5616.213730077874, 5650.717464126695], "value": 4195.944368912329, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.501336571083, 724.1961422820672, 798.4929569723224, 819.9016118065833, 857.5112186053948, 14104.929475352621, 15145.469908553203, 15146.924265378657, 15149.0, 15189.088654680727, 13993.300334983262, 14161.71676566468, 14191.0, 14250.358733856976, 14414.711705765878, 669.4209508774924, 797.3063434811722, 797.9601019949008, 811.1280373598405, 826.0046643794213, 812.0580127052621, 816.9591520423985, 818.9467684600481, 819.6639377855081, 820.0446479850966, 853.3898262742138, 853.5007020892785, 854.8803167556547, 855.5380094748829, 855.6064210463195, 705.6683358821346, 799.6281728996045, 820.4420993724265, 821.6384790692076, 851.1318455175717, 606.287612055837, 610.3987572241339, 610.5787006965224, 610.8686632374016, 610.9083637454418, 13973.09174903628, 13997.650058748512, 14006.089604175697, 14021.158730476203, 14035.368408421646, 12873.356332183446, 13217.140885842486, 13743.862561374359, 14007.439702411892, 14058.367373468218, 12497.25016499013, 12499.500019999188, 12555.246685198917, 12561.748765024648, 12625.558105466265, 4232.957670423318, 4239.236937351276, 4296.763677997709, 4314.611684948339, 4327.0913108247305, 55414.0, 55586.72206638981, 55631.721841390936, 56029.71985140089, 56158.43841561614, 10340.844887326695, 10466.21503387249, 10570.365778053341, 10593.205509586813, 10729.678109656723, 19835.50411239702, 19990.100445479988, 20064.297749578694, 20088.89955550213, 20109.798902011084, 7791.181925897812, 7834.138244793068, 7925.8811117833275, 8051.2351326623875, 8070.394720395994, 4411.4926783420315, 4451.287793952952, 4526.185286648435, 4537.977310113428, 4665.766711664471, 3317.1872891141825, 3378.0, 3403.3193361327835, 3410.0963244740165, 3413.9487907681405, 591.4174538079988, 595.1637948682109, 599.691159053088, 604.2054698072021, 612.8192183305936, 627.959182653126, 655.2824657000576, 703.6235613946617, 734.3537686835657, 736.3593673503979, 8759.649614015496, 8846.601902914384, 8981.281497480186, 9314.72055838326, 9348.252139828797, 704.8167476456056, 711.2567367101392, 720.9639518024078, 726.8727972604773, 729.7336472187613, 4150.896227594334, 4322.6325762309925, 4406.581374769392, 4479.115748730551, 4532.6827122101795, 64796.35203647903, 65201.347986519526, 66102.66948665226, 66686.33313666898, 67512.0, 41495.0, 42077.579224207366, 52992.470075298756, 57115.71442142763, 61714.382856170865, 53073.93852122936, 54058.0, 54671.45328546664, 54697.72651136798, 55528.0, 7761.72833950809, 8044.798880028046, 8226.465279756796, 8249.133840946613, 8368.41421100517, 35285.0, 35619.10952226215, 35851.64148358483, 36286.818565907, 36461.817690911375, 43245.78377108094, 45674.54325456836, 46387.304190436495, 48096.7595162022, 49302.26046609232, 12735.745285094432, 12864.099513033998, 12900.935495322463, 12947.611571652866, 13237.073404861567, 13805.516806912112, 14063.578092657237, 14256.42974281017, 14482.275886205436, 14850.995115659247, 12905.548305809252, 13270.601881943558, 13464.93267533656, 13518.391672374963, 13659.931700341434, 12637.93681031589, 13157.473701051851, 13613.828085683155, 13899.264851976872, 14202.869569564647, 13102.0, 13256.734865302833, 13310.800337994744, 13316.134451260637, 13376.488634502113, 9856.704298871045, 9915.900840991499, 10231.28381013322, 10432.061114499731, 10434.739131521772, 10931.070858977077, 10996.450177490933, 11081.27971681838, 11345.602903898323, 11445.25605835618], "value": 6806.428094854345, "unit": "score"}], "name": "dromaeo_css", "value": 7214.781919725401, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 109.0, 109.0, 108.0, 109.0, 111.0, 108.0, 109.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 129.0, 187.0, 124.0, 134.0, 161.0, 126.0, 185.0, 134.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 127.0, 73.0, 74.0, 75.0, 74.0, 97.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 83.0, 84.0, 84.0, 126.0, 84.0, 83.0, 131.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 55.0, 54.0, 52.0, 53.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 79.0, 80.0, 81.0, 83.0, 81.0, 109.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 120.0, 125.0, 117.0, 117.0, 118.0, 120.0, 126.0, 120.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 165.0, 163.0, 160.0, 157.0, 157.0, 162.0, 157.0, 158.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 62.0, 66.0, 62.0, 61.0, 61.0, 65.0, 60.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1495.1000000000001, "alertThreshold": 2.0}]} 14:50:20 INFO - Return code: 0 14:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:50:20 ERROR - # TBPL SUCCESS # 14:50:20 INFO - Running post-action listener: _resource_record_post_action 14:50:20 INFO - ##### 14:50:20 INFO - ##### Finished run-tests step (success) 14:50:20 INFO - ##### 14:50:20 INFO - Running post-run listener: _resource_record_post_run 14:50:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541974528; Read time: 8; Write time: 474780 14:50:20 INFO - TinderboxPrint: CPU usage
13.2% 14:50:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:50:20 INFO - TinderboxPrint: I/O write bytes / time
541,974,528 / 474,780 14:50:20 INFO - TinderboxPrint: CPU idle
8,259.5 (86.8%) 14:50:20 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 14:50:20 INFO - TinderboxPrint: Swap in / out
0 / 0 14:50:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243130368; Read time: 0; Write time: 245248 14:50:20 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285839360; Read time: 8; Write time: 228240 14:50:20 INFO - Running post-run listener: _upload_blobber_files 14:50:20 INFO - Blob upload gear active. 14:50:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:50:20 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 14:50:21 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'] 14:50:21 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 14:50:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:50:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:24 INFO - (blobuploader) - INFO - Done attempting. 14:50:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:50:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:25 INFO - (blobuploader) - INFO - Done attempting. 14:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:26 INFO - (blobuploader) - INFO - Done attempting. 14:50:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:50:26 INFO - Return code: 0 14:50:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:50:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:50:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/193fc9cdcc671018f020f62d4ed55231676ecd76519f0bdc0026a85d68a960e6ff3476b2fd8a3c89c07a68bb38190fd8b0f0edd9c2eb61ed30717af026558049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec49f392784a4e13a293a3f5fbe50ec6063dcf458e1a3261e24e9237208a9626182cad08928791c4de569e8dd4f284f0c10f37ec00f71518bd2c185f98d4eaff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a15556842441c87869de5e60cc701a5cfe6ab6722005b061b1c8df876d6079012c5eb16f07d8334a882cf991bdeadcf6fc677ee0ac441a6c80f32d6fe6120c1a"} 14:50:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:50:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:50:26 INFO - Contents: 14:50:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/193fc9cdcc671018f020f62d4ed55231676ecd76519f0bdc0026a85d68a960e6ff3476b2fd8a3c89c07a68bb38190fd8b0f0edd9c2eb61ed30717af026558049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec49f392784a4e13a293a3f5fbe50ec6063dcf458e1a3261e24e9237208a9626182cad08928791c4de569e8dd4f284f0c10f37ec00f71518bd2c185f98d4eaff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a15556842441c87869de5e60cc701a5cfe6ab6722005b061b1c8df876d6079012c5eb16f07d8334a882cf991bdeadcf6fc677ee0ac441a6c80f32d6fe6120c1a"} 14:50:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:50:26 INFO - Copying logs to upload dir... 14:50:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:50:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.859089 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 14:50:26.535940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 14:50:26.539064) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/193fc9cdcc671018f020f62d4ed55231676ecd76519f0bdc0026a85d68a960e6ff3476b2fd8a3c89c07a68bb38190fd8b0f0edd9c2eb61ed30717af026558049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec49f392784a4e13a293a3f5fbe50ec6063dcf458e1a3261e24e9237208a9626182cad08928791c4de569e8dd4f284f0c10f37ec00f71518bd2c185f98d4eaff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a15556842441c87869de5e60cc701a5cfe6ab6722005b061b1c8df876d6079012c5eb16f07d8334a882cf991bdeadcf6fc677ee0ac441a6c80f32d6fe6120c1a"} build_url:https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011528 build_url: 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/193fc9cdcc671018f020f62d4ed55231676ecd76519f0bdc0026a85d68a960e6ff3476b2fd8a3c89c07a68bb38190fd8b0f0edd9c2eb61ed30717af026558049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec49f392784a4e13a293a3f5fbe50ec6063dcf458e1a3261e24e9237208a9626182cad08928791c4de569e8dd4f284f0c10f37ec00f71518bd2c185f98d4eaff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a15556842441c87869de5e60cc701a5cfe6ab6722005b061b1c8df876d6079012c5eb16f07d8334a882cf991bdeadcf6fc677ee0ac441a6c80f32d6fe6120c1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 14:50:26.564698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:50:26.565056) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464816591.205877-587750210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:50:26.651069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 14:50:26.651389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 14:50:26.651715) ========= ========= Total master_lag: 0.19 =========