builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1462976740.83 results: success (0) buildid: 20160511055210 builduid: 50fa9985e4634107b7dcd265f1723e55 revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.829814) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.831288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.831560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.846733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.847051) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 07:25:41-- 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% 212M=0s 2016-05-11 07:25:41 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.999569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:40.999861) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014325 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:41.050035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 07:25:41.050385) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91714307a799b978b0a94911cd99ee75a1de0ac5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 91714307a799b978b0a94911cd99ee75a1de0ac5 --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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 07:25:41,262 truncating revision to first 12 chars 2016-05-11 07:25:41,262 Setting DEBUG logging. 2016-05-11 07:25:41,262 attempt 1/10 2016-05-11 07:25:41,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91714307a799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 07:25:42,023 unpacking tar archive at: mozilla-central-91714307a799/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 07:25:42.098504) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:42.098827) ========= script_repo_revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:42.099247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:42.099515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 07:25:42.109983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-11 07:25:42.110389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:42 INFO - MultiFileLogger online at 20160511 07:25:42 in /builds/slave/test 07:25:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:42 INFO - {'append_to_log': False, 07:25:42 INFO - 'base_work_dir': '/builds/slave/test', 07:25:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:42 INFO - 'branch': 'Firefox-Non-PGO', 07:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:42 INFO - 'config_files': ('talos/linux_config.py',), 07:25:42 INFO - 'default_actions': ('clobber', 07:25:42 INFO - 'read-buildbot-config', 07:25:42 INFO - 'download-and-extract', 07:25:42 INFO - 'populate-webroot', 07:25:42 INFO - 'create-virtualenv', 07:25:42 INFO - 'install', 07:25:42 INFO - 'run-tests'), 07:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:42 INFO - 'download_minidump_stackwalk': True, 07:25:42 INFO - 'download_symbols': 'ondemand', 07:25:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:42 INFO - 'installer_path': 'installer.exe', 07:25:42 INFO - 'log_level': 'info', 07:25:42 INFO - 'log_name': 'talos', 07:25:42 INFO - 'log_to_console': True, 07:25:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:42 INFO - 'opt_config_files': (), 07:25:42 INFO - 'pip_index': False, 07:25:42 INFO - 'sps_profile': False, 07:25:42 INFO - 'sps_profile_interval': 0, 07:25:42 INFO - 'suite': 'dromaeojs', 07:25:42 INFO - 'system_bits': '32', 07:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:42 INFO - 'title': 'talos-linux64-ix-002', 07:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:42 INFO - 'use_talos_json': True, 07:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:42 INFO - 'work_dir': 'build'} 07:25:42 INFO - ##### 07:25:42 INFO - ##### Running clobber step. 07:25:42 INFO - ##### 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: clobber 07:25:42 INFO - rmtree: /builds/slave/test/build 07:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - ##### 07:25:42 INFO - ##### Finished clobber step (success) 07:25:42 INFO - ##### 07:25:42 INFO - ##### 07:25:42 INFO - ##### Running read-buildbot-config step. 07:25:42 INFO - ##### 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: read_buildbot_config 07:25:42 INFO - Using buildbot properties: 07:25:42 INFO - { 07:25:42 INFO - "project": "", 07:25:42 INFO - "product": "firefox", 07:25:42 INFO - "script_repo_revision": "production", 07:25:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:25:42 INFO - "repository": "", 07:25:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:25:42 INFO - "buildid": "20160511055210", 07:25:42 INFO - "pgo_build": "False", 07:25:42 INFO - "basedir": "/builds/slave/test", 07:25:42 INFO - "buildnumber": 571, 07:25:42 INFO - "slavename": "talos-linux64-ix-002", 07:25:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:25:42 INFO - "platform": "ubuntu64_hw", 07:25:42 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:25:42 INFO - "branch": "mozilla-central", 07:25:42 INFO - "repo_path": "mozilla-central", 07:25:42 INFO - "revision": "91714307a799b978b0a94911cd99ee75a1de0ac5", 07:25:42 INFO - "stage_platform": "linux64", 07:25:42 INFO - "builduid": "50fa9985e4634107b7dcd265f1723e55", 07:25:42 INFO - "slavebuilddir": "test" 07:25:42 INFO - } 07:25:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - ##### 07:25:42 INFO - ##### Finished read-buildbot-config step (success) 07:25:42 INFO - ##### 07:25:42 INFO - ##### 07:25:42 INFO - ##### Running download-and-extract step. 07:25:42 INFO - ##### 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: download_and_extract 07:25:42 INFO - mkdir: /builds/slave/test/build/tests 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:42 INFO - https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:43 INFO - Downloaded 1361 bytes. 07:25:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:43 INFO - Using the following test package requirements: 07:25:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'jsshell-linux-x86_64.zip'], 07:25:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:43 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')]} 07:25:43 INFO - https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:45 INFO - Downloaded 22328750 bytes. 07:25:45 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'] 07:25:45 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 07:25:46 INFO - Return code: 0 07:25:46 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 07:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:46 INFO - https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:48 INFO - Downloaded 22328750 bytes. 07:25:48 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'] 07:25:48 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 07:25:49 INFO - Return code: 0 07:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:49 INFO - https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:50 INFO - Downloaded 10840152 bytes. 07:25:50 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'] 07:25:50 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 07:25:50 INFO - Return code: 0 07:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:50 INFO - https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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 07:25:52 INFO - Downloaded 54674862 bytes. 07:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:52 INFO - mkdir: /builds/slave/test/properties 07:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:52 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:52 INFO - Contents: 07:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:52 INFO - Running post-action listener: _resource_record_post_action 07:25:52 INFO - Running post-action listener: set_extra_try_arguments 07:25:52 INFO - ##### 07:25:52 INFO - ##### Finished download-and-extract step (success) 07:25:52 INFO - ##### 07:25:52 INFO - ##### 07:25:52 INFO - ##### Running populate-webroot step. 07:25:52 INFO - ##### 07:25:52 INFO - Running pre-action listener: _resource_record_pre_action 07:25:52 INFO - Running main action method: populate_webroot 07:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:52 INFO - '--tppagecycles', 07:25:52 INFO - '7'], 07:25:52 INFO - 'tests': ['tsvgm']}}, 07:25:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['damp', 'tps']}, 07:25:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'tests': ['damp', 'tps']}, 07:25:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['dromaeo_dom']}, 07:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['a11yr', 07:25:52 INFO - 'ts_paint', 07:25:52 INFO - 'tpaint', 07:25:52 INFO - 'sessionrestore', 07:25:52 INFO - 'sessionrestore_no_auto_restore', 07:25:52 INFO - 'tabpaint']}, 07:25:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['tsvgx', 07:25:52 INFO - 'tsvgr_opacity', 07:25:52 INFO - 'tart', 07:25:52 INFO - 'tscrollx', 07:25:52 INFO - 'cart']}, 07:25:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:52 INFO - 'tsvgr_opacity', 07:25:52 INFO - 'tart', 07:25:52 INFO - 'tscrollx', 07:25:52 INFO - 'cart']}, 07:25:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'talos_options': ['--disable-e10s'], 07:25:52 INFO - 'tests': ['tp5o']}, 07:25:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'tests': ['tp5o']}, 07:25:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'talos_options': ['--disable-e10s', 07:25:52 INFO - '--xperf_path', 07:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:52 INFO - 'tests': ['tp5n']}, 07:25:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:52 INFO - 'talos_options': ['--xperf_path', 07:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:52 INFO - 'tests': ['tp5n']}}, 07:25:52 INFO - 'talos.zip': {'path': '', 07:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:52 INFO - Running post-action listener: _resource_record_post_action 07:25:52 INFO - ##### 07:25:52 INFO - ##### Finished populate-webroot step (success) 07:25:52 INFO - ##### 07:25:52 INFO - ##### 07:25:52 INFO - ##### Running create-virtualenv step. 07:25:52 INFO - ##### 07:25:52 INFO - Running pre-action listener: _resource_record_pre_action 07:25:52 INFO - Running main action method: create_virtualenv 07:25:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:53 INFO - Using real prefix '/usr' 07:25:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:55 INFO - Installing pip.................done. 07:25:55 INFO - Return code: 0 07:25:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:25:55 INFO - Using env: {'DISPLAY': ':0', 07:25:55 INFO - 'HOME': '/home/cltbld', 07:25:55 INFO - 'LANG': 'en_US.UTF-8', 07:25:55 INFO - 'LANGUAGE': 'en_US:en', 07:25:55 INFO - 'LOGNAME': 'cltbld', 07:25:55 INFO - 'MAIL': '/var/mail/cltbld', 07:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:55 INFO - 'MOZ_NO_REMOTE': '1', 07:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:55 INFO - 'NO_EM_RESTART': '1', 07:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:55 INFO - 'PWD': '/builds/slave/test', 07:25:55 INFO - 'SHELL': '/bin/bash', 07:25:55 INFO - 'SHLVL': '1', 07:25:55 INFO - 'TERM': 'linux', 07:25:55 INFO - 'TMOUT': '86400', 07:25:55 INFO - 'USER': 'cltbld', 07:25:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:55 INFO - '_': '/tools/buildbot/bin/python'} 07:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:25:55 INFO - Cleaning up... 07:25:55 INFO - Return code: 0 07:25:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:25:55 INFO - Using env: {'DISPLAY': ':0', 07:25:55 INFO - 'HOME': '/home/cltbld', 07:25:55 INFO - 'LANG': 'en_US.UTF-8', 07:25:55 INFO - 'LANGUAGE': 'en_US:en', 07:25:55 INFO - 'LOGNAME': 'cltbld', 07:25:55 INFO - 'MAIL': '/var/mail/cltbld', 07:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:55 INFO - 'MOZ_NO_REMOTE': '1', 07:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:55 INFO - 'NO_EM_RESTART': '1', 07:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:55 INFO - 'PWD': '/builds/slave/test', 07:25:55 INFO - 'SHELL': '/bin/bash', 07:25:55 INFO - 'SHLVL': '1', 07:25:55 INFO - 'TERM': 'linux', 07:25:55 INFO - 'TMOUT': '86400', 07:25:55 INFO - 'USER': 'cltbld', 07:25:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:55 INFO - '_': '/tools/buildbot/bin/python'} 07:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:55 INFO - Downloading/unpacking psutil>=0.7.1 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:57 INFO - Installing collected packages: psutil 07:25:57 INFO - Running setup.py install for psutil 07:25:58 INFO - building 'psutil._psutil_linux' extension 07:25:58 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 07:25:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:25:58 INFO - building 'psutil._psutil_posix' extension 07:25:58 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 07:25:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:58 INFO - Successfully installed psutil 07:25:58 INFO - Cleaning up... 07:25:58 INFO - Return code: 0 07:25:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:25:58 INFO - Using env: {'DISPLAY': ':0', 07:25:58 INFO - 'HOME': '/home/cltbld', 07:25:58 INFO - 'LANG': 'en_US.UTF-8', 07:25:58 INFO - 'LANGUAGE': 'en_US:en', 07:25:58 INFO - 'LOGNAME': 'cltbld', 07:25:58 INFO - 'MAIL': '/var/mail/cltbld', 07:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:58 INFO - 'MOZ_NO_REMOTE': '1', 07:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:58 INFO - 'NO_EM_RESTART': '1', 07:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:58 INFO - 'PWD': '/builds/slave/test', 07:25:58 INFO - 'SHELL': '/bin/bash', 07:25:58 INFO - 'SHLVL': '1', 07:25:58 INFO - 'TERM': 'linux', 07:25:58 INFO - 'TMOUT': '86400', 07:25:58 INFO - 'USER': 'cltbld', 07:25:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:58 INFO - '_': '/tools/buildbot/bin/python'} 07:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:26:00 INFO - Installing collected packages: mozsystemmonitor 07:26:00 INFO - Running setup.py install for mozsystemmonitor 07:26:00 INFO - Successfully installed mozsystemmonitor 07:26:00 INFO - Cleaning up... 07:26:00 INFO - Return code: 0 07:26:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:26:00 INFO - Using env: {'DISPLAY': ':0', 07:26:00 INFO - 'HOME': '/home/cltbld', 07:26:00 INFO - 'LANG': 'en_US.UTF-8', 07:26:00 INFO - 'LANGUAGE': 'en_US:en', 07:26:00 INFO - 'LOGNAME': 'cltbld', 07:26:00 INFO - 'MAIL': '/var/mail/cltbld', 07:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:00 INFO - 'MOZ_NO_REMOTE': '1', 07:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:00 INFO - 'NO_EM_RESTART': '1', 07:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:00 INFO - 'PWD': '/builds/slave/test', 07:26:00 INFO - 'SHELL': '/bin/bash', 07:26:00 INFO - 'SHLVL': '1', 07:26:00 INFO - 'TERM': 'linux', 07:26:00 INFO - 'TMOUT': '86400', 07:26:00 INFO - 'USER': 'cltbld', 07:26:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:00 INFO - '_': '/tools/buildbot/bin/python'} 07:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:26:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:26:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:03 INFO - Downloading docopt-0.6.1.tar.gz 07:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:26:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:26:03 INFO - Running setup.py install for blobuploader 07:26:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:26:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:26:03 INFO - Running setup.py install for requests 07:26:04 INFO - Running setup.py install for docopt 07:26:04 INFO - Successfully installed blobuploader requests docopt 07:26:04 INFO - Cleaning up... 07:26:04 INFO - Return code: 0 07:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:04 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')]} 07:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:04 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')]} 07:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:04 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 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26:04 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 07:26:04 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 07:26:04 INFO - Using env: {'DISPLAY': ':0', 07:26:04 INFO - 'HOME': '/home/cltbld', 07:26:04 INFO - 'LANG': 'en_US.UTF-8', 07:26:04 INFO - 'LANGUAGE': 'en_US:en', 07:26:04 INFO - 'LOGNAME': 'cltbld', 07:26:04 INFO - 'MAIL': '/var/mail/cltbld', 07:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:04 INFO - 'MOZ_NO_REMOTE': '1', 07:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:04 INFO - 'NO_EM_RESTART': '1', 07:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:04 INFO - 'PWD': '/builds/slave/test', 07:26:04 INFO - 'SHELL': '/bin/bash', 07:26:04 INFO - 'SHLVL': '1', 07:26:04 INFO - 'TERM': 'linux', 07:26:04 INFO - 'TMOUT': '86400', 07:26:04 INFO - 'USER': 'cltbld', 07:26:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:04 INFO - '_': '/tools/buildbot/bin/python'} 07:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:26:04 INFO - Running setup.py (path:/tmp/pip-QZBdTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:26:04 INFO - Running setup.py (path:/tmp/pip-JIPd0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:26:04 INFO - Running setup.py (path:/tmp/pip-UuoHxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:26:04 INFO - Running setup.py (path:/tmp/pip-QnPG53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:26:04 INFO - Running setup.py (path:/tmp/pip-sg2rxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:26:04 INFO - Running setup.py (path:/tmp/pip-eSUuxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:26:04 INFO - Running setup.py (path:/tmp/pip-SXl7ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:26:04 INFO - Running setup.py (path:/tmp/pip-g7qYft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:26:05 INFO - Running setup.py (path:/tmp/pip-zJc3r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:26:05 INFO - Running setup.py (path:/tmp/pip-xFT96k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:26:05 INFO - Running setup.py (path:/tmp/pip-7wXHhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:26:05 INFO - Running setup.py (path:/tmp/pip-YfP7nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:26:05 INFO - Running setup.py (path:/tmp/pip-Opw0Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:26:05 INFO - Running setup.py (path:/tmp/pip-N1cpQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:05 INFO - Running setup.py (path:/tmp/pip-3yFoOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:26:05 INFO - Running setup.py (path:/tmp/pip-6f818o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:26:05 INFO - Running setup.py (path:/tmp/pip-gNSmGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:26:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:26:05 INFO - Running setup.py install for manifestparser 07:26:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:26:05 INFO - Running setup.py install for mozcrash 07:26:05 INFO - Running setup.py install for mozdebug 07:26:05 INFO - Running setup.py install for mozdevice 07:26:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozfile 07:26:06 INFO - Running setup.py install for mozhttpd 07:26:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozinfo 07:26:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozInstall 07:26:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozleak 07:26:06 INFO - Running setup.py install for mozlog 07:26:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for moznetwork 07:26:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozprocess 07:26:06 INFO - Running setup.py install for mozprofile 07:26:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Running setup.py install for mozrunner 07:26:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:26:07 INFO - Running setup.py install for mozscreenshot 07:26:07 INFO - Running setup.py install for moztest 07:26:07 INFO - Running setup.py install for mozversion 07:26:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:26:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:26:07 INFO - Cleaning up... 07:26:07 INFO - Return code: 0 07:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:07 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 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26:07 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 07:26:07 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 07:26:07 INFO - Using env: {'DISPLAY': ':0', 07:26:07 INFO - 'HOME': '/home/cltbld', 07:26:07 INFO - 'LANG': 'en_US.UTF-8', 07:26:07 INFO - 'LANGUAGE': 'en_US:en', 07:26:07 INFO - 'LOGNAME': 'cltbld', 07:26:07 INFO - 'MAIL': '/var/mail/cltbld', 07:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:07 INFO - 'MOZ_NO_REMOTE': '1', 07:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:07 INFO - 'NO_EM_RESTART': '1', 07:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:07 INFO - 'PWD': '/builds/slave/test', 07:26:07 INFO - 'SHELL': '/bin/bash', 07:26:07 INFO - 'SHLVL': '1', 07:26:07 INFO - 'TERM': 'linux', 07:26:07 INFO - 'TMOUT': '86400', 07:26:07 INFO - 'USER': 'cltbld', 07:26:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:07 INFO - '_': '/tools/buildbot/bin/python'} 07:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:26:07 INFO - Running setup.py (path:/tmp/pip-tufZF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:26:07 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)) 07:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:26:07 INFO - Running setup.py (path:/tmp/pip-r2LkWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:26:07 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)) 07:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:26:07 INFO - Running setup.py (path:/tmp/pip-ecjjn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:26:07 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)) 07:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:26:07 INFO - Running setup.py (path:/tmp/pip-4FaaHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:26:07 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)) 07:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:26:07 INFO - Running setup.py (path:/tmp/pip-xeYhEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:26:08 INFO - Running setup.py (path:/tmp/pip-lGTMnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:26:08 INFO - Running setup.py (path:/tmp/pip-U5rhkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:26:08 INFO - Running setup.py (path:/tmp/pip-TDKQ7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:26:08 INFO - Running setup.py (path:/tmp/pip-Z9_Vg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:26:08 INFO - Running setup.py (path:/tmp/pip-31mGVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:26:08 INFO - Running setup.py (path:/tmp/pip-In8TYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:26:08 INFO - Running setup.py (path:/tmp/pip-FnSYl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:26:08 INFO - Running setup.py (path:/tmp/pip-yu5DGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:26:08 INFO - Running setup.py (path:/tmp/pip-_ylKzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:08 INFO - Running setup.py (path:/tmp/pip-9ndfKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:26:08 INFO - Running setup.py (path:/tmp/pip-Y3eWrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:26:08 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)) 07:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:26:08 INFO - Running setup.py (path:/tmp/pip-qs_yhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:26:08 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)) 07:26:08 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)) 07:26:08 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)) 07:26:08 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)) 07:26:08 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)) 07:26:08 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)) 07:26:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:26:08 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 07:26:08 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 07:26:08 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 07:26:08 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 07:26:08 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 07:26:08 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 07:26:10 INFO - Downloading blessings-1.6.tar.gz 07:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:26:10 INFO - Installing collected packages: blessings 07:26:10 INFO - Running setup.py install for blessings 07:26:10 INFO - Successfully installed blessings 07:26:10 INFO - Cleaning up... 07:26:11 INFO - Return code: 0 07:26:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:11 INFO - Reading from file tmpfile_stdout 07:26:11 INFO - Current package versions: 07:26:11 INFO - argparse == 1.2.1 07:26:11 INFO - blessings == 1.6 07:26:11 INFO - blobuploader == 1.2.4 07:26:11 INFO - docopt == 0.6.1 07:26:11 INFO - manifestparser == 1.1 07:26:11 INFO - mozInstall == 1.12 07:26:11 INFO - mozcrash == 0.17 07:26:11 INFO - mozdebug == 0.1 07:26:11 INFO - mozdevice == 0.48 07:26:11 INFO - mozfile == 1.2 07:26:11 INFO - mozhttpd == 0.7 07:26:11 INFO - mozinfo == 0.9 07:26:11 INFO - mozleak == 0.1 07:26:11 INFO - mozlog == 3.1 07:26:11 INFO - moznetwork == 0.27 07:26:11 INFO - mozprocess == 0.22 07:26:11 INFO - mozprofile == 0.28 07:26:11 INFO - mozrunner == 6.11 07:26:11 INFO - mozscreenshot == 0.1 07:26:11 INFO - mozsystemmonitor == 0.0 07:26:11 INFO - moztest == 0.7 07:26:11 INFO - mozversion == 1.4 07:26:11 INFO - psutil == 3.1.1 07:26:11 INFO - requests == 1.2.3 07:26:11 INFO - wsgiref == 0.1.2 07:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26: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')]} 07:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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')]} 07:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:11 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 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26:11 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 07:26:11 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 07:26:11 INFO - Using env: {'DISPLAY': ':0', 07:26:11 INFO - 'HOME': '/home/cltbld', 07:26:11 INFO - 'LANG': 'en_US.UTF-8', 07:26:11 INFO - 'LANGUAGE': 'en_US:en', 07:26:11 INFO - 'LOGNAME': 'cltbld', 07:26:11 INFO - 'MAIL': '/var/mail/cltbld', 07:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:11 INFO - 'MOZ_NO_REMOTE': '1', 07:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:11 INFO - 'NO_EM_RESTART': '1', 07:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:11 INFO - 'PWD': '/builds/slave/test', 07:26:11 INFO - 'SHELL': '/bin/bash', 07:26:11 INFO - 'SHLVL': '1', 07:26:11 INFO - 'TERM': 'linux', 07:26:11 INFO - 'TMOUT': '86400', 07:26:11 INFO - 'USER': 'cltbld', 07:26:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:11 INFO - '_': '/tools/buildbot/bin/python'} 07:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 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)) 07:26:11 INFO - Cleaning up... 07:26:11 INFO - Return code: 0 07:26:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:26: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')]} 07:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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')]} 07:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26: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', 'jsonschema'] in /builds/slave/test/build 07:26: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 jsonschema 07:26:11 INFO - Using env: {'DISPLAY': ':0', 07:26:11 INFO - 'HOME': '/home/cltbld', 07:26:11 INFO - 'LANG': 'en_US.UTF-8', 07:26:11 INFO - 'LANGUAGE': 'en_US:en', 07:26:11 INFO - 'LOGNAME': 'cltbld', 07:26:11 INFO - 'MAIL': '/var/mail/cltbld', 07:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:11 INFO - 'MOZ_NO_REMOTE': '1', 07:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:11 INFO - 'NO_EM_RESTART': '1', 07:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:11 INFO - 'PWD': '/builds/slave/test', 07:26:11 INFO - 'SHELL': '/bin/bash', 07:26:11 INFO - 'SHLVL': '1', 07:26:11 INFO - 'TERM': 'linux', 07:26:11 INFO - 'TMOUT': '86400', 07:26:11 INFO - 'USER': 'cltbld', 07:26:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:11 INFO - '_': '/tools/buildbot/bin/python'} 07:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:11 INFO - Downloading/unpacking jsonschema 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:26:13 INFO - Downloading/unpacking functools32 (from jsonschema) 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:26:13 INFO - warning: no files found matching '*.txt' 07:26:13 INFO - no previously-included directories found matching 'build' 07:26:13 INFO - no previously-included directories found matching 'dist' 07:26:13 INFO - no previously-included directories found matching '.git*' 07:26:13 INFO - Installing collected packages: jsonschema, functools32 07:26:13 INFO - Running setup.py install for functools32 07:26:13 INFO - warning: no files found matching '*.txt' 07:26:13 INFO - no previously-included directories found matching 'build' 07:26:13 INFO - no previously-included directories found matching 'dist' 07:26:13 INFO - no previously-included directories found matching '.git*' 07:26:13 INFO - Successfully installed jsonschema functools32 07:26:13 INFO - Cleaning up... 07:26:14 INFO - Return code: 0 07:26:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940ea0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', '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 07:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:26:14 INFO - Using env: {'DISPLAY': ':0', 07:26:14 INFO - 'HOME': '/home/cltbld', 07:26:14 INFO - 'LANG': 'en_US.UTF-8', 07:26:14 INFO - 'LANGUAGE': 'en_US:en', 07:26:14 INFO - 'LOGNAME': 'cltbld', 07:26:14 INFO - 'MAIL': '/var/mail/cltbld', 07:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:14 INFO - 'MOZ_NO_REMOTE': '1', 07:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:14 INFO - 'NO_EM_RESTART': '1', 07:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:14 INFO - 'PWD': '/builds/slave/test', 07:26:14 INFO - 'SHELL': '/bin/bash', 07:26:14 INFO - 'SHLVL': '1', 07:26:14 INFO - 'TERM': 'linux', 07:26:14 INFO - 'TMOUT': '86400', 07:26:14 INFO - 'USER': 'cltbld', 07:26:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:14 INFO - '_': '/tools/buildbot/bin/python'} 07:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:14 INFO - Downloading/unpacking flake8 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:26:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:26:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 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 07:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:16 INFO - no previously-included directories found matching 'docs/_build' 07:26:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:26:16 INFO - Running setup.py install for pep8 07:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:16 INFO - no previously-included directories found matching 'docs/_build' 07:26:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:26:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:26:17 INFO - Cleaning up... 07:26:17 INFO - Return code: 0 07:26:17 INFO - Running post-action listener: _resource_record_post_action 07:26:17 INFO - Running post-action listener: _start_resource_monitoring 07:26:17 INFO - Starting resource monitoring. 07:26:17 INFO - ##### 07:26:17 INFO - ##### Finished create-virtualenv step (success) 07:26:17 INFO - ##### 07:26:17 INFO - ##### 07:26:17 INFO - ##### Running install step. 07:26:17 INFO - ##### 07:26:17 INFO - Running pre-action listener: _resource_record_pre_action 07:26:17 INFO - Running main action method: install 07:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:17 INFO - Reading from file tmpfile_stdout 07:26:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:26:17 INFO - Reading from file tmpfile_stdout 07:26:17 INFO - Output received: 07:26:17 INFO - Usage: mozinstall [options] installer 07:26:17 INFO - Options: 07:26:17 INFO - -h, --help show this help message and exit 07:26:17 INFO - -d DEST, --destination=DEST 07:26:17 INFO - Directory to install application into. [default: 07:26:17 INFO - "/builds/slave/test"] 07:26:17 INFO - --app=APP Application being installed. [default: firefox] 07:26:17 INFO - mkdir: /builds/slave/test/build/application 07:26:17 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'] 07:26:17 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 07:26:33 INFO - Reading from file tmpfile_stdout 07:26:33 INFO - Output received: 07:26:33 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:33 INFO - Running post-action listener: _resource_record_post_action 07:26:33 INFO - ##### 07:26:33 INFO - ##### Finished install step (success) 07:26:33 INFO - ##### 07:26:33 INFO - ##### 07:26:33 INFO - ##### Running run-tests step. 07:26:33 INFO - ##### 07:26:33 INFO - Running pre-action listener: _resource_record_pre_action 07:26:33 INFO - Running main action method: run_tests 07:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:33 INFO - Python 2.7.3 07:26:33 INFO - Return code: 0 07:26:33 INFO - grabbing minidump binary from tooltool 07:26:33 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')]} 07:26:33 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 0x24109c0>, '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 0x24118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:33 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 07:26:33 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 07:26:33 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 07:26:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:33 INFO - Return code: 0 07:26:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:34 INFO - Return code: 0 07:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 07:26:34 INFO - Using env: {'DISPLAY': ':0', 07:26:34 INFO - 'HOME': '/home/cltbld', 07:26:34 INFO - 'LANG': 'en_US.UTF-8', 07:26:34 INFO - 'LANGUAGE': 'en_US:en', 07:26:34 INFO - 'LOGNAME': 'cltbld', 07:26:34 INFO - 'MAIL': '/var/mail/cltbld', 07:26:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:34 INFO - 'MOZ_NO_REMOTE': '1', 07:26:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:34 INFO - 'NO_EM_RESTART': '1', 07:26:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:34 INFO - 'PWD': '/builds/slave/test', 07:26:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:34 INFO - 'SHELL': '/bin/bash', 07:26:34 INFO - 'SHLVL': '1', 07:26:34 INFO - 'TERM': 'linux', 07:26:34 INFO - 'TMOUT': '86400', 07:26:34 INFO - 'USER': 'cltbld', 07:26:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180', 07:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:34 INFO - '_': '/tools/buildbot/bin/python'} 07:26:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:26:34 INFO - mozversion application_buildid: 20160511055210 07:26:34 INFO - mozversion application_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 07:26:34 INFO - mozversion application_display_name: Nightly 07:26:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:34 INFO - mozversion application_name: Firefox 07:26:34 INFO - mozversion application_remotingname: firefox 07:26:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:34 INFO - mozversion application_vendor: Mozilla 07:26:34 INFO - mozversion application_version: 49.0a1 07:26:34 INFO - mozversion platform_buildid: 20160511055210 07:26:34 INFO - mozversion platform_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 07:26:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:34 INFO - mozversion platform_version: 49.0a1 07:26:34 INFO - using testdate: 1462976794 07:26:34 INFO - actual date: 1462976794 07:26:34 INFO - starting webserver on 'localhost:46180' 07:26:34 INFO - SUITE-START | Running 2 tests 07:26:34 INFO - TEST-START | dromaeo_css 07:26:34 INFO - operating with platform_type : linux_ 07:26:34 INFO - Initialising browser for dromaeo_css test... 07:26:34 INFO - TEST-INFO | started process 10976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkcJf4/profile http://localhost:46180/getInfo.html) 07:26:38 INFO - PROCESS | 10976 | __metrics Screen width/height:1600/1200 07:26:38 INFO - PROCESS | 10976 | colorDepth:24 07:26:38 INFO - PROCESS | 10976 | Browser inner width/height: 1024/697 07:26:38 INFO - PROCESS | 10976 | __metrics 07:26:39 ERROR - PROCESS | 10976 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:26:40 INFO - TEST-INFO | 10976: exit 0 07:26:40 INFO - Browser initialized. 07:26:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:40 INFO - TEST-INFO | started process 11057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkcJf4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:52 INFO - PROCESS | 11057 | RSS: Main: 153972736 07:26:52 INFO - PROCESS | 11057 | 07:27:44 INFO - PROCESS | 11057 | 1462976864269 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] 07:29:55 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46180/tests/dromaeo/cssquery-ext.html) 07:29:57 INFO - PROCESS | 11057 | RSS: Main: 265027584 07:29:57 INFO - PROCESS | 11057 | 07:32:59 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-ext.html (next: http://localhost:46180/tests/dromaeo/cssquery-jquery.html) 07:33:00 INFO - PROCESS | 11057 | RSS: Main: 234500096 07:33:00 INFO - PROCESS | 11057 | 07:36:02 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46180/tests/dromaeo/cssquery-mootools.html) 07:36:03 INFO - PROCESS | 11057 | RSS: Main: 243896320 07:36:03 INFO - PROCESS | 11057 | 07:39:05 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46180/tests/dromaeo/cssquery-prototype.html) 07:39:06 INFO - PROCESS | 11057 | RSS: Main: 232013824 07:39:06 INFO - PROCESS | 11057 | 07:42:09 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46180/tests/dromaeo/cssquery-yui.html) 07:42:09 INFO - PROCESS | 11057 | RSS: Main: 225087488 07:42:09 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | Cycle 1(1): loaded http://localhost:46180/tests/dromaeo/cssquery-yui.html (next: http://localhost:46180/tests/dromaeo/cssquery-dojo.html) 07:45:12 INFO - PROCESS | 11057 | RSS: Main: 265621504 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | __start_tp_report 07:45:12 INFO - PROCESS | 11057 | _x_x_mozilla_page_load 07:45:12 INFO - PROCESS | 11057 | _x_x_mozilla_page_load_details 07:45:12 INFO - PROCESS | 11057 | |i|pagename|runs| 07:45:12 INFO - PROCESS | 11057 | |0;dojo.html;2672.211697549223;2691.017778510844;2720.251930719053;2722.754952054315;2734.753872151507;4749.145153872301;4791.472937976824;4791.976040119795;4870.318155458234;4936.3829521309835;4670.462896766873;4716.080364328957;4732.10090082884;4770.904581908359;4779.545943135406;4341.2836881914445;4406.118776244748;4431.202383570972;4461.308497182942;4592.058627981272;4524.502304746492;4541.65937554683;4545.045540436512;4569.97175635481;4603.355530225755;4313.072689371768;4315.654747620214;4359.869203923888;4363.367311739812;4386.34204869269;4341.6526677865695;4412.051408947092;4426.535213802536;4427.203103441379;4461.107778444291;4445.177642136183;4459.710118842265;4466.865994020184;4469.3296005599095;4508.481524624644;4606.539346065367;4629.560191781776;4646.53534646536;4769.809207631691;4823.517648235148;5133.050385678662;5135.281060651511;5164.948350516484;5182.300389447414;5187.688738675692;5117.437081920985;5123.257127716461;5186.481351864821;5191;5202.375714914197;4622.121796858653;4788.569028787426;4795.976020119877;4830.468648448667;4837;5339.599530035263;5340.626156169031;5367.1412573988755;5370.570354371641;5390.272313237741;5110.233464980282;5147.227915812583;5158.045761534128;5159.7678104485385;5161.612879034087;4984.177610694267;5069.518395752398;5126.436092029874;5203.089459344599;5209.166533354645;5123.820666276737;5124.564412024945;5147.6911385317;5160;5179.974100129475;5092.083424983464;5098.289915294819;5100.56645185156;5102.846914592568;5150.124478838607;4175.206710724952;4209.410682504452;4312.072904325585;4322.265214913472;4360.672949528798;3725.403935370328;3763.736538442283;3792.7724336539895;3800.1639639279865;3827.75119617224;4396.670249731283;4404.07514421975;4405.757683327448;4405.867823965286;4451.1765323415275;4921.2864134700985;5034.672746271481;5137.357830271216;5150.665206761549;5202.76587553561;4338.8047537860875;4348.391225228471;4360.345948107809;4397.890052748643;4403.625691816232;4502.482214545304;4535.750533720677;4536.047430039663;4545.477270113913;4588.88527786808;4716.551927566876;4758.76206189696;4764.904701905943;4812.975935120302;4853.927191092066;5155.742212889416;5172.094883395315;5177.275181474522;5181.248718935658;5218.191180367049;4855.393075865517;4868.513148685103;4868.926966095582;4869.878253043702;4917.1149193145575;4979.850604481871;5014.398272207359;5076.36545431821;5079.060373830853;5091.719955402488;5150.433452320317;5165.380154381498;5168.3539557555305;5169.741512924414;5178.559822414986;4998.950010499849;4999.700017998932;5009.073321435546;5010.5240002199735;5036.445990941067;4852.223644216909;4888.291197776373;4894.314795928644;4899.951000489949;4942.6293028023765;4802.399700037496;4843.467218606021;4880.682755620874;4881.048195601824;4882.95117048825;4917.631177661761;4926.433460151985;4931;4966.404031516096;4975;4727.220008698526;4755.500672429345;4756.9524304756505;4949.82675606352;4993.775280112331 07:45:12 INFO - PROCESS | 11057 | |1;ext.html;567.6849348611521;604.5194070713782;607.2773399654413;607.726523064621;618.292055596342;40772.38841417377;42280.57719422805;42373.78813105934;42379.78810105945;46316;41332.58667413325;41745.58254417455;41753.16493670125;41771.37342939858;41781.16437671245;7528;7751.6124193790365;7760;7891.28978391946;8046.637901294456;7726.497777644463;10029.147522460564;10317;10330.7417314567;10719.35683858967;10352.327098738559;10354.326968747007;10357.689269321932;10358.482075896212;10362.067413932744;7681;10145.644902428416;10211.438370889598;10214.336068155546;10221.89778102217;9695.806083878282;9790.608375664964;10074.597016119347;10081.143102836268;10086.9495652522;40504.59495405038;41004;41117.79441102775;41126.177476450604;41203;3286;3346.5147553604593;3664.193877346979;3725.590185079639;4091.9386209206887;29564.260893477836;30085.849570752223;30162.54756178637;30328.526639517742;30938;3199.808011519293;3237.4172648923186;3271.8364081795817;3315.0717799016315;3383.644717304672;255918;256890;257295;257349;258677;60813.83082438042;61287.08069378963;61305.38694612997;61352.38647613556;61399.38600614026;36547.81726091352;37549;37661.05847353838;38963.80518097391;38985.6101438982;13928.721425571432;13984.510542130976;14047.719045619031;14057.297135143202;14076.788848167285;10798.78402431947;11416.42917854104;11544.249623774427;11603.477843497063;11826.467808948619;20279;20378.388648340573;20415.693764593543;20479.180832766524;20628.58742825135;7475.439342049368;7561.848763024709;7620;7652.47468335448;7775.650095745705;845.4420082745481;996.8165539196209;1084.8426978088132;1090.5201711247184;1104.861892263467;28172;28193;28712.425751484854;28939.85530072336;28972.710272897424;998.8202123617673;1027.5941003303653;1064.0583083970741;1091.7216109892086;1096.7258185453636;14797.408103675732;15293.311800968982;15359.462418815288;15737.213139342986;15746.76379854303;357872;359906;360731;362152;362214;51753;52013.219801703;52013.47986520162;52189.47810521846;52416.73791631017;1159.2291126401017;1184.3722826901583;1256.7737807194792;1279.7952327627536;1311.5278499740086;27002.864985674947;29346.853265733534;29997.850010749808;30381;30544;43063.56936430596;43433.34849977316;43511;43694.34458483189;43697.344539832564;276466;276474;276684;277877;278419;23294.534109318058;26066;26259.343516412242;27256;27274.727252727218;43699.12601747883;43783.562164377945;44171.337429937936;44520.55479445294;44818.55181448144;35396.646033539335;35851.82074089613;36722.26555468822;36804.631953680124;36857.63142368542;36222;36434.8178259107;36552.81723591365;36675.633243667224;36891;36270.4559431614;36469.81765091157;37320.62679373172;37385;37386.43920341143;30786;32245.838770805996;32873.50689739608;33025;33183;25349.493010139326;25768.742312577386;25819.870900645376;25896;26046.08838690637 07:45:12 INFO - PROCESS | 11057 | |2;jquery.html;380.3208833002295;383.7045474984264;385.4757529759527;387.36085458992676;403.6589082225518;15885.364585416584;17155.399561015365;17958.281668733252;18010.189541470634;18079.819201807994;17039.14804259788;17352;17548.348408375405;17831.73252401215;17889;5089.312942752727;5220.634555581111;5224.503672151159;5252.737363131847;5294.391145018314;3696.5194524711883;3851.826667799956;4046.453728746611;5998.580099393044;6033.607815492001;5921.348651648315;6023.126646636235;6054.394560543955;6068.120122582223;6074.908876366858;6037.0642550404755;6068.757249710006;6074.544409169308;6075.058365953284;6080.452759251689;3388.220709236865;3547.5388199534154;3551.485034669984;3579.677828995377;4973.751312434364;20772.79227207739;20949;21078.78921210799;21211.893940530354;21284.467888302763;2004.5589970206531;2019.5153163240864;2047.9692804607944;2215.4461384653837;2627.0805218173678;6437.485001199892;6477.125588045601;6481.675916204171;12349.259044457362;13254.933725331312;1796.5418818201406;1805.702059160237;1835.7062869940746;1878.953026174343;1884.9340273090377;68041.65979170123;69267.30732692659;69826.30173698299;70229;71559;9333.953330233306;9593.184579310837;9784.902150978542;10326.070653641209;10340.500375479296;13385.464581416829;13478.528251511347;13481;13495.190288582717;13499.392527336293;7259.745908893164;7278.308560686726;7351.742689005859;7423.888641670379;7466.925330746732;7113.53762005468;7136.215016348197;7188.137423509108;7288.453365997465;7295.234000429985;6261.123442718023;6319.431251187323;6347.96826015867;6416.7433302668305;6418.486521078303;1710.4270069526847;1741.1555395633109;1741.5965966965507;1791.9462416127537;1807.1416077363147;851.9148085191431;882.1134759566722;914.9908500915038;947.5830634520927;1000.9399436033862;16770.496885093467;17032.403865864635;17261.827381726274;17309.65380692379;17652.382166624106;896.8654701794652;928.4150984879483;936.3258453913172;948.7533241357158;963.4749061761357;9700.90299097014;10069.848952265722;10222.744431389276;10247.77026756794;10257.199144489134;291985;410581;425165;426355;427789;60955;72052;72164.63917680379;73335.26664733284;73611.63194184101;896.3143195455482;941.4868896451451;1003.6487229469773;1004.382304882492;1007.8387458006683;15763;15819.762703559225;15947.920260398623;16184.352625894833;16249.10629915366;35000.82499587486;35153.64846351606;35303.470447943815;35414.739978304904;35808.820955895055;49006.26490602715;50540;50562.49437505578;51197.744011279705;51361.74319128381;6658.067870498037;7081;7298.379637730853;7827.295543401121;8058.838823223386;7328.303811137934;11024.228304018963;11964.401779911144;12018.639440816789;12304.138710290194;10539.104176145114;10556.102731267621;10573.577056917637;10625.681229563126;10717;10563.20775941792;10593.629222977159;10599.205059620404;10614.427947251066;10624.415657138932;7192.820179495555;10742.140628749838;10912.127029837753;10925;11074.778504430027;7359.889601655872;7382.151052629017;7408.925910740823;7513.248675132661;7544.09470863478;8958.68644597436;10718.19613529004;10855.2401331906;10930.070943969851;10971.615993440191 07:45:12 INFO - PROCESS | 11057 | |3;mootools.html;1289.9935500322497;1524.992375038125;1562.1876624155439;1727.9136043197846;1896.1656870976778;7549.660265288061;7942.046954365477;7958.24396682315;8178.754637360874;8189.140140285273;7914.445988780788;8093.352531797457;8097.311728503069;8098.51408915464;8104.554249516289;1916.3867562380044;1985.2158397433004;1991.273185287367;2275.055851821492;2328.592496313147;2026.2806703620224;2272.4318920269934;2338.205010296499;2338.8422730748302;2357.316378250314;2171.457135716071;2209.8232141428725;2216.1024784962037;2232.48652809853;2236.027328112268;1860.55346716787;2162.7729088445644;2166.1876796201504;2171.4679903423603;2172.945676358104;2118.152738904435;2183.4213933307688;2186.256672731279;2198.373463562877;2208.6024515587187;7885.408594355389;7943.324817390529;7945.761627151137;7956.164602716689;8000.9199908000755;4576.199165146086;4665.650076244261;4669.2062349400685;4691.601213896823;4705.788239529229;2739.356251280947;2830.0519326025806;2897.768178545711;2908.7527560157414;2908.956365654517;883.9779005524849;889.8121008453722;916.2990312411011;917.6833992272656;926.8424367857481;10489.213309001856;10501.842472362921;10534.78930421395;10537.262391632512;10537.78924421515;4363.978180109079;4497.347884556721;4554.544545545486;4607.585317321457;4610.216263235258;9071.818563628822;9097;9105;9118.133777291147;9119.224865886341;4865.051314993613;4923.827666031743;4933.605311575066;4939.209726443752;4947.035328110984;3448.3103379324234;3812.4853144825647;4334.5882141196535;4432.689711720213;4452.465704115527;3777.4522694209186;3876.3604005339366;3878.7284890057426;3908.2769687607883;3911.159100793343;1263.0653316545875;1277.916935399196;1288.7358091591202;1291.541502766523;1305.5822136916286;903.4172958441768;907.1472815553359;925.000998921177;931.1433481197315;937.329809186435;5611.186377975171;5611.803586874522;5774.335951365647;5781.364049954502;5891.440313170242;912.8950170730318;945.7210123013728;957.1959553974694;962.1869520255512;973.2068364283086;3758.586555478895;3826.3877779555696;3833.865814696472;3944.6647035001774;3950.8734822559977;9624.855627165458;9926.851097233548;10030.799384012425;10167.237457190593;10172.338797978256;9887;9902.960189180176;9918.355306905029;9921.851172232422;10050.899491004997;7504.437167212481;7628.0464941882265;7646.770596882103;7676.961615191888;7679.2320767923875;5329.467053294795;5364.785408583613;5460;5577.051901176728;5661.150827375926;8786.472811631322;8801.647934082564;9233.169014788702;9261.72214833556;9398.295127865575;9228.169464748205;9358.204552613104;9405.623775048922;9501.857472138061;9517.666881659386;6055.273367195965;7158.355747982707;7407.888881666887;7414.703411863465;7418.146913105062;7244.275572442713;7286.125664920243;7293.635318233961;7466.178720340867;7479.513831600929;6727.360900714424;6855.897161542481;6872.62200578973;6943.444524438134;6969.686364113526;6780.966095169492;6809.114815074008;6829.385355318045;6883.3116688330765;6894.482913781386;6153.4154255345675;6317.684115794284;6556.18047744032;6565.704543295467;6693.397594216349;4711.764411779466;4734.502877197982;4760.143174228672;4772.403449568804;4863.805447782191;4802.111609352281;4811.27830825365;4838.225883858566;4867.853964381075;4915.090708218991 07:45:12 INFO - PROCESS | 11057 | |4;prototype.html;301.817400472714;303.3160223695566;312.7451127331224;316.0471179394127;316.90492852144354;4630.606398456135;4719.150552900476;4760.452852822834;4813.411574180521;4853.5389138031915;4534.410526631534;4704.435467743867;4725.14947309485;4728.787204575794;4783.306420569015;3758.7368884178118;3798.9620103798884;3803.7147213958924;3804.4673745675627;3840.577536471;3645.8359373828107;3703.4444833274956;3814.5803961564343;3818.961810381902;3829.7893615851117;3761.586225515191;3781.773093614392;3782.678472329855;3798.8670396536127;3801.923961520768;3782;3790.65884070435;3791.4502397152532;3791.848326066982;3793.1275806564367;3396.439587468065;3399.0285634332026;3400.0989737719524;3403.4384326586082;3424.503447000171;4454.13144436835;4540.772961351952;4541.750203738793;4542.250528662767;4567.33773602829;4292.570742925714;4294.57054294568;4304.80628371724;4325.762083085429;4338.284183109783;4895.265710143472;4960.627952903546;4970.676906001098;4972.801087956477;5003.849884503471;3462.774919630216;3648.5256916600674;3656.6526180012856;3660.359437098497;3668.559772827251;5169.81905633301;5208.453112423217;5221.425643179247;5222.921656175123;5225.634205605609;3802.657760801541;3809.5999920008553;3820.541535015816;3822.3119838429348;3838.347480928249;3792.412176112707;3833.5208098987628;3853.325668008087;3880.980595097063;3917.843286268517;4288.8284468620905;4298.3552467130185;4302.139572085595;4324.978375108167;4327.8485253016;4958.975205123951;4977.278294647256;4985.354832905133;5010.69935803853;5011.423686276052;1231.7228623559627;1265.4685032286461;1266.290877108822;1276.2087505746497;1287.3305880941857;913.7258822353267;938.8075444533854;939.6899023322287;950.3537594435712;954.3367359685091;4371.5082403029965;4385;4392;4403.581659742319;4437.267850804581;4911.582515486224;5110.872228194251;5124.026434977342;5124.66689665178;5147.227915812583;4350.825277175145;4366.410534577855;4366.868993930188;4375.912481750347;4382.255016647114;2693.205504376214;2699;2701.9324516887236;2711.9322016949736;2716.6009505104885;4633.7683115844075;4774.116788394158;4787.521247875185;4807.326974223612;4955.554000140005;5341.973290133525;5362.835926803127;5373.543248823816;5377.3816011159215;5377.462253774669;4888.291197776373;4917.213245880642;4922.8769280768265;4933.76655836041;4935.654504184673;4968.950310496849;5144.9163088949035;5169.4830516948;5174;5178.249153872743;5046.116929537243;5090.490950905028;5104.310918026019;5107.41264754558;5136.844210052708;4942.7034377936;4959.528844759742;4971.776270067783;4998.225275082368;4999.275105109811;3520.5071290018905;3710.2394009227505;3726.5155529780955;3736.5889752127787;3758.4362345648374;5123.538881500683;5176.7152806596;5182.6113041521285;5219;5222.582193424441;4933.802647894044;4992.850214493571;5017.448080711046;5026.637480384214;5106.336176297058;4761.000189960008;4774.450938142019;5021.698698078127;5031.899362012812;5037.647364684583;4847.248676455155;4938.012397520582;4942.332785073969;4962.975185124052;4988.9251661225835;5017.724025178651;5058.647728806123;5097.413797413345;5122.436531981553;5161.509656582619;4795.256735206049;4969.850904472872;4988.301637770643;5001.399832020181;5067.6199285053035 07:45:12 INFO - PROCESS | 11057 | |5;yui.html;661.1174082599729;680.8570200257946;682.4676752133338;716.0905649824726;736.5580651609032;11865.466054027567;12044;12557.183783054095;12765.170263932861;12776.872231277684;13460.394282257297;14126.505572304972;14287.14277143372;14295;14306.141631502118;692.5429216716968;855.7389996051202;874.1215078845751;889.244142478891;890.1143362354467;879.4151888993812;880.106691707917;882.7042940614901;882.7131182365724;882.8940527136721;923.852183650616;925.3383830561147;925.773185569533;925.9953700231489;926.0369216015335;723.1502983993812;874.9650013999433;905.9139381758722;908.7955210077746;919.5264438814016;676.3034074902858;677.2617846547287;677.6340775980964;678.047343482408;678.7658257901016;11322.660320190407;11356.375399353032;11393.487293071832;11400.144989125765;11412.258203216765;11167.553297868075;11406.315621062762;11446.484908179153;11626.418679066013;11723.824142637868;11250.831237531444;11332.093432525378;11379.317240965485;11433.771324573545;11523.48144333507;4118.052847845012;4118.464599602063;4151.937720934188;4184.19238492973;4269.210196113729;46049.76975115103;46079.308810367875;46207.306890396336;46432.07135857264;46789.53210467886;8546.914530854736;8704.216620504185;8770.38607297483;8777.517236551923;8823.294136469067;15998.600034999217;16156.515304540882;16169.59576010609;16171.110588917723;16195.838041619669;6399.968000159969;6443.871122577522;6627.204735431779;6656.600603963778;6703.966480167568;3519.3137338218803;3544.964550354515;3781.9810900945317;3795.6773674237447;3817.408301713239;2658.41514866729;2736.3022429280404;2737.534619114755;2743.82165159268;2746.780257579389;522.589767032885;529.7483695244728;534.1613666543567;536.1689381458723;544.3413469701705;555.1035078348439;589.5048159546002;614.4991831657185;623.7847942459844;634.1724050114552;8009.399295052895;8314.833703326021;8362.247397734232;8412.453190542596;8520.531370774543;526.2579762534807;531.9015982043335;539.5090467674476;541.4937033873263;546.1507356061284;3762.2663580602066;3797.3354662933875;3837.6162383761957;3843.238175035435;3847.9038024049623;49003.26495102576;51484;51531;51583.226251606255;51699;44226.33660495095;44353.334699979525;44923.77538112288;46907.29639055417;47442;41835.163296733896;42175.57824421778;42563.14873702508;42760.3585946211;43018;7271;7336.229695881855;7350.632468376667;7436.628168591657;7492.51298665585;29053.854730727056;29605;29821.552676709434;29889.10332690023;30345.848270758506;35255.82372088123;37478.25043499169;38000.61999379971;38086.23827523489;38559.228815424096;9227.630894764134;9326.160645541933;9372.67195648149;9466.715998520056;9480.668176613786;10084.949575252076;10173.796524069625;10258.538365773707;11720.355380454157;11882.524699011943;9408.529573521433;9694.739683841055;11383.886161138282;11813.82279265829;11845.289282643069;11333.716657083638;11357.659270221906;11749.823752643546;11910.642680719593;11974.880251197377;11213.102951763676;11241.943790280997;11374.431278435879;11632.141022251828;11804.232724872856;9599.808003840024;9777.560009799434;9927.602895884083;9933.400725456486;10022.849657255292;10041.347312424668;10102.065698261795;10254.23093267993;10263.281570290008;10265.538050787882 07:45:12 INFO - PROCESS | 11057 | __end_tp_report 07:45:12 INFO - PROCESS | 11057 | __start_cc_report 07:45:12 INFO - PROCESS | 11057 | _x_x_mozilla_cycle_collect,1028 07:45:12 INFO - PROCESS | 11057 | __end_cc_report 07:45:12 INFO - PROCESS | 11057 | __startTimestamp1462977912568__endTimestamp 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | ------- Summary: start ------- 07:45:12 INFO - PROCESS | 11057 | Number of tests: 6 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#0] dojo.html Cycles:165 Average:4734.90 Median:4852.22 stddev:500.53 (10.3%) stddev-sans-first:475.19 07:45:12 INFO - PROCESS | 11057 | Values: 2672.2 2691.0 2720.3 2722.8 2734.8 4749.1 4791.5 4792.0 4870.3 4936.4 4670.5 4716.1 4732.1 4770.9 4779.5 4341.3 4406.1 4431.2 4461.3 4592.1 4524.5 4541.7 4545.0 4570.0 4603.4 4313.1 4315.7 4359.9 4363.4 4386.3 4341.7 4412.1 4426.5 4427.2 4461.1 4445.2 4459.7 4466.9 4469.3 4508.5 4606.5 4629.6 4646.5 4769.8 4823.5 5133.1 5135.3 5164.9 5182.3 5187.7 5117.4 5123.3 5186.5 5191.0 5202.4 4622.1 4788.6 4796.0 4830.5 4837.0 5339.6 5340.6 5367.1 5370.6 5390.3 5110.2 5147.2 5158.0 5159.8 5161.6 4984.2 5069.5 5126.4 5203.1 5209.2 5123.8 5124.6 5147.7 5160.0 5180.0 5092.1 5098.3 5100.6 5102.8 5150.1 4175.2 4209.4 4312.1 4322.3 4360.7 3725.4 3763.7 3792.8 3800.2 3827.8 4396.7 4404.1 4405.8 4405.9 4451.2 4921.3 5034.7 5137.4 5150.7 5202.8 4338.8 4348.4 4360.3 4397.9 4403.6 4502.5 4535.8 4536.0 4545.5 4588.9 4716.6 4758.8 4764.9 4813.0 4853.9 5155.7 5172.1 5177.3 5181.2 5218.2 4855.4 4868.5 4868.9 4869.9 4917.1 4979.9 5014.4 5076.4 5079.1 5091.7 5150.4 5165.4 5168.4 5169.7 5178.6 4999.0 4999.7 5009.1 5010.5 5036.4 4852.2 4888.3 4894.3 4900.0 4942.6 4802.4 4843.5 4880.7 4881.0 4883.0 4917.6 4926.4 4931.0 4966.4 4975.0 4727.2 4755.5 4757.0 4949.8 4993.8 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#1] ext.html Cycles:180 Average:46363.62 Median:18170.04 stddev:78955.75 (434.5%) stddev-sans-first:79102.37 07:45:12 INFO - PROCESS | 11057 | Values: 567.7 604.5 607.3 607.7 618.3 40772.4 42280.6 42373.8 42379.8 46316.0 41332.6 41745.6 41753.2 41771.4 41781.2 7528.0 7751.6 7760.0 7891.3 8046.6 7726.5 10029.1 10317.0 10330.7 10719.4 10352.3 10354.3 10357.7 10358.5 10362.1 7681.0 10145.6 10211.4 10214.3 10221.9 9695.8 9790.6 10074.6 10081.1 10086.9 40504.6 41004.0 41117.8 41126.2 41203.0 3286.0 3346.5 3664.2 3725.6 4091.9 29564.3 30085.8 30162.5 30328.5 30938.0 3199.8 3237.4 3271.8 3315.1 3383.6 255918.0 256890.0 257295.0 257349.0 258677.0 60813.8 61287.1 61305.4 61352.4 61399.4 36547.8 37549.0 37661.1 38963.8 38985.6 13928.7 13984.5 14047.7 14057.3 14076.8 10798.8 11416.4 11544.2 11603.5 11826.5 20279.0 20378.4 20415.7 20479.2 20628.6 7475.4 7561.8 7620.0 7652.5 7775.7 845.4 996.8 1084.8 1090.5 1104.9 28172.0 28193.0 28712.4 28939.9 28972.7 998.8 1027.6 1064.1 1091.7 1096.7 14797.4 15293.3 15359.5 15737.2 15746.8 357872.0 359906.0 360731.0 362152.0 362214.0 51753.0 52013.2 52013.5 52189.5 52416.7 1159.2 1184.4 1256.8 1279.8 1311.5 27002.9 29346.9 29997.9 30381.0 30544.0 43063.6 43433.3 43511.0 43694.3 43697.3 276466.0 276474.0 276684.0 277877.0 278419.0 23294.5 26066.0 26259.3 27256.0 27274.7 43699.1 43783.6 44171.3 44520.6 44818.6 35396.6 35851.8 36722.3 36804.6 36857.6 36222.0 36434.8 36552.8 36675.6 36891.0 36270.5 36469.8 37320.6 37385.0 37386.4 30786.0 32245.8 32873.5 33025.0 33183.0 25349.5 25768.7 25819.9 25896.0 26046.1 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#2] jquery.html Cycles:180 Average:24374.15 Median:382.01 stddev:65841.54 (17235.4%) stddev-sans-first:66001.60 07:45:12 INFO - PROCESS | 11057 | Values: 380.3 383.7 385.5 387.4 403.7 15885.4 17155.4 17958.3 18010.2 18079.8 17039.1 17352.0 17548.3 17831.7 17889.0 5089.3 5220.6 5224.5 5252.7 5294.4 3696.5 3851.8 4046.5 5998.6 6033.6 5921.3 6023.1 6054.4 6068.1 6074.9 6037.1 6068.8 6074.5 6075.1 6080.5 3388.2 3547.5 3551.5 3579.7 4973.8 20772.8 20949.0 21078.8 21211.9 21284.5 2004.6 2019.5 2048.0 2215.4 2627.1 6437.5 6477.1 6481.7 12349.3 13254.9 1796.5 1805.7 1835.7 1879.0 1884.9 68041.7 69267.3 69826.3 70229.0 71559.0 9334.0 9593.2 9784.9 10326.1 10340.5 13385.5 13478.5 13481.0 13495.2 13499.4 7259.7 7278.3 7351.7 7423.9 7466.9 7113.5 7136.2 7188.1 7288.5 7295.2 6261.1 6319.4 6348.0 6416.7 6418.5 1710.4 1741.2 1741.6 1791.9 1807.1 851.9 882.1 915.0 947.6 1000.9 16770.5 17032.4 17261.8 17309.7 17652.4 896.9 928.4 936.3 948.8 963.5 9700.9 10069.8 10222.7 10247.8 10257.2 291985.0 410581.0 425165.0 426355.0 427789.0 60955.0 72052.0 72164.6 73335.3 73611.6 896.3 941.5 1003.6 1004.4 1007.8 15763.0 15819.8 15947.9 16184.4 16249.1 35000.8 35153.6 35303.5 35414.7 35808.8 49006.3 50540.0 50562.5 51197.7 51361.7 6658.1 7081.0 7298.4 7827.3 8058.8 7328.3 11024.2 11964.4 12018.6 12304.1 10539.1 10556.1 10573.6 10625.7 10717.0 10563.2 10593.6 10599.2 10614.4 10624.4 7192.8 10742.1 10912.1 10925.0 11074.8 7359.9 7382.2 7408.9 7513.2 7544.1 8958.7 10718.2 10855.2 10930.1 10971.6 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#3] mootools.html Cycles:180 Average:5289.12 Median:5412.39 stddev:2930.61 (54.1%) stddev-sans-first:2923.42 07:45:12 INFO - PROCESS | 11057 | Values: 1290.0 1525.0 1562.2 1727.9 1896.2 7549.7 7942.0 7958.2 8178.8 8189.1 7914.4 8093.4 8097.3 8098.5 8104.6 1916.4 1985.2 1991.3 2275.1 2328.6 2026.3 2272.4 2338.2 2338.8 2357.3 2171.5 2209.8 2216.1 2232.5 2236.0 1860.6 2162.8 2166.2 2171.5 2172.9 2118.2 2183.4 2186.3 2198.4 2208.6 7885.4 7943.3 7945.8 7956.2 8000.9 4576.2 4665.7 4669.2 4691.6 4705.8 2739.4 2830.1 2897.8 2908.8 2909.0 884.0 889.8 916.3 917.7 926.8 10489.2 10501.8 10534.8 10537.3 10537.8 4364.0 4497.3 4554.5 4607.6 4610.2 9071.8 9097.0 9105.0 9118.1 9119.2 4865.1 4923.8 4933.6 4939.2 4947.0 3448.3 3812.5 4334.6 4432.7 4452.5 3777.5 3876.4 3878.7 3908.3 3911.2 1263.1 1277.9 1288.7 1291.5 1305.6 903.4 907.1 925.0 931.1 937.3 5611.2 5611.8 5774.3 5781.4 5891.4 912.9 945.7 957.2 962.2 973.2 3758.6 3826.4 3833.9 3944.7 3950.9 9624.9 9926.9 10030.8 10167.2 10172.3 9887.0 9903.0 9918.4 9921.9 10050.9 7504.4 7628.0 7646.8 7677.0 7679.2 5329.5 5364.8 5460.0 5577.1 5661.2 8786.5 8801.6 9233.2 9261.7 9398.3 9228.2 9358.2 9405.6 9501.9 9517.7 6055.3 7158.4 7407.9 7414.7 7418.1 7244.3 7286.1 7293.6 7466.2 7479.5 6727.4 6855.9 6872.6 6943.4 6969.7 6781.0 6809.1 6829.4 6883.3 6894.5 6153.4 6317.7 6556.2 6565.7 6693.4 4711.8 4734.5 4760.1 4772.4 4863.8 4802.1 4811.3 4838.2 4867.9 4915.1 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#4] prototype.html Cycles:180 Average:4187.49 Median:4726.97 stddev:1196.12 (25.3%) stddev-sans-first:1163.37 07:45:12 INFO - PROCESS | 11057 | Values: 301.8 303.3 312.7 316.0 316.9 4630.6 4719.2 4760.5 4813.4 4853.5 4534.4 4704.4 4725.1 4728.8 4783.3 3758.7 3799.0 3803.7 3804.5 3840.6 3645.8 3703.4 3814.6 3819.0 3829.8 3761.6 3781.8 3782.7 3798.9 3801.9 3782.0 3790.7 3791.5 3791.8 3793.1 3396.4 3399.0 3400.1 3403.4 3424.5 4454.1 4540.8 4541.8 4542.3 4567.3 4292.6 4294.6 4304.8 4325.8 4338.3 4895.3 4960.6 4970.7 4972.8 5003.8 3462.8 3648.5 3656.7 3660.4 3668.6 5169.8 5208.5 5221.4 5222.9 5225.6 3802.7 3809.6 3820.5 3822.3 3838.3 3792.4 3833.5 3853.3 3881.0 3917.8 4288.8 4298.4 4302.1 4325.0 4327.8 4959.0 4977.3 4985.4 5010.7 5011.4 1231.7 1265.5 1266.3 1276.2 1287.3 913.7 938.8 939.7 950.4 954.3 4371.5 4385.0 4392.0 4403.6 4437.3 4911.6 5110.9 5124.0 5124.7 5147.2 4350.8 4366.4 4366.9 4375.9 4382.3 2693.2 2699.0 2701.9 2711.9 2716.6 4633.8 4774.1 4787.5 4807.3 4955.6 5342.0 5362.8 5373.5 5377.4 5377.5 4888.3 4917.2 4922.9 4933.8 4935.7 4969.0 5144.9 5169.5 5174.0 5178.2 5046.1 5090.5 5104.3 5107.4 5136.8 4942.7 4959.5 4971.8 4998.2 4999.3 3520.5 3710.2 3726.5 3736.6 3758.4 5123.5 5176.7 5182.6 5219.0 5222.6 4933.8 4992.9 5017.4 5026.6 5106.3 4761.0 4774.5 5021.7 5031.9 5037.6 4847.2 4938.0 4942.3 4963.0 4988.9 5017.7 5058.6 5097.4 5122.4 5161.5 4795.3 4969.9 4988.3 5001.4 5067.6 07:45:12 INFO - PROCESS | 11057 | 07:45:12 INFO - PROCESS | 11057 | [#5] yui.html Cycles:180 Average:12656.70 Median:44638.56 stddev:14236.99 (31.9%) stddev-sans-first:14248.43 07:45:12 INFO - PROCESS | 11057 | Values: 661.1 680.9 682.5 716.1 736.6 11865.5 12044.0 12557.2 12765.2 12776.9 13460.4 14126.5 14287.1 14295.0 14306.1 692.5 855.7 874.1 889.2 890.1 879.4 880.1 882.7 882.7 882.9 923.9 925.3 925.8 926.0 926.0 723.2 875.0 905.9 908.8 919.5 676.3 677.3 677.6 678.0 678.8 11322.7 11356.4 11393.5 11400.1 11412.3 11167.6 11406.3 11446.5 11626.4 11723.8 11250.8 11332.1 11379.3 11433.8 11523.5 4118.1 4118.5 4151.9 4184.2 4269.2 46049.8 46079.3 46207.3 46432.1 46789.5 8546.9 8704.2 8770.4 8777.5 8823.3 15998.6 16156.5 16169.6 16171.1 16195.8 6400.0 6443.9 6627.2 6656.6 6704.0 3519.3 3545.0 3782.0 3795.7 3817.4 2658.4 2736.3 2737.5 2743.8 2746.8 522.6 529.7 534.2 536.2 544.3 555.1 589.5 614.5 623.8 634.2 8009.4 8314.8 8362.2 8412.5 8520.5 526.3 531.9 539.5 541.5 546.2 3762.3 3797.3 3837.6 3843.2 3847.9 49003.3 51484.0 51531.0 51583.2 51699.0 44226.3 44353.3 44923.8 46907.3 47442.0 41835.2 42175.6 42563.1 42760.4 43018.0 7271.0 7336.2 7350.6 7436.6 7492.5 29053.9 29605.0 29821.6 29889.1 30345.8 35255.8 37478.3 38000.6 38086.2 38559.2 9227.6 9326.2 9372.7 9466.7 9480.7 10084.9 10173.8 10258.5 11720.4 11882.5 9408.5 9694.7 11383.9 11813.8 11845.3 11333.7 11357.7 11749.8 11910.6 11974.9 11213.1 11241.9 11374.4 11632.1 11804.2 9599.8 9777.6 9927.6 9933.4 10022.8 10041.3 10102.1 10254.2 10263.3 10265.5 07:45:12 INFO - PROCESS | 11057 | -------- Summary: end -------- 07:45:12 INFO - PROCESS | 11057 | 07:45:13 INFO - TEST-INFO | 11057: exit 0 07:45:13 INFO - TEST-OK | dromaeo_css | took 1118934ms 07:45:13 INFO - TEST-START | kraken 07:45:13 INFO - operating with platform_type : linux_ 07:45:13 INFO - Initialising browser for kraken test... 07:45:13 INFO - TEST-INFO | started process 11242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWwazoW/profile http://localhost:46180/getInfo.html) 07:45:17 INFO - PROCESS | 11242 | __metrics Screen width/height:1600/1200 07:45:17 INFO - PROCESS | 11242 | colorDepth:24 07:45:17 INFO - PROCESS | 11242 | Browser inner width/height: 1024/697 07:45:17 INFO - PROCESS | 11242 | __metrics 07:45:18 ERROR - PROCESS | 11242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:45:19 INFO - TEST-INFO | 11242: exit 0 07:45:19 INFO - Browser initialized. 07:45:19 INFO - Running cycle 1/1 for kraken test... 07:45:19 INFO - TEST-INFO | started process 11323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWwazoW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:31 INFO - PROCESS | 11323 | RSS: Main: 154419200 07:45:31 INFO - PROCESS | 11323 | 07:45:34 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46180/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:35 INFO - PROCESS | 11323 | RSS: Main: 209895424 07:45:35 INFO - PROCESS | 11323 | 07:45:37 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46180/tests/kraken/driver.html?testName=audio-dft) 07:45:38 INFO - PROCESS | 11323 | RSS: Main: 197332992 07:45:38 INFO - PROCESS | 11323 | 07:45:41 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46180/tests/kraken/driver.html?testName=audio-fft) 07:45:42 INFO - PROCESS | 11323 | RSS: Main: 267075584 07:45:42 INFO - PROCESS | 11323 | 07:45:44 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46180/tests/kraken/driver.html?testName=audio-oscillator) 07:45:45 INFO - PROCESS | 11323 | RSS: Main: 175992832 07:45:45 INFO - PROCESS | 11323 | 07:45:47 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:48 INFO - PROCESS | 11323 | RSS: Main: 179884032 07:45:48 INFO - PROCESS | 11323 | 07:45:51 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46180/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:52 INFO - PROCESS | 11323 | RSS: Main: 215728128 07:45:52 INFO - PROCESS | 11323 | 07:45:55 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46180/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:56 INFO - PROCESS | 11323 | RSS: Main: 214163456 07:45:56 INFO - PROCESS | 11323 | 07:45:59 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46180/tests/kraken/driver.html?testName=json-parse-financial) 07:46:00 INFO - PROCESS | 11323 | RSS: Main: 214331392 07:46:00 INFO - PROCESS | 11323 | 07:46:01 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:46:02 INFO - PROCESS | 11323 | RSS: Main: 210096128 07:46:02 INFO - PROCESS | 11323 | 07:46:04 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:46:05 INFO - PROCESS | 11323 | RSS: Main: 209956864 07:46:05 INFO - PROCESS | 11323 | 07:46:07 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:46:08 INFO - PROCESS | 11323 | RSS: Main: 215707648 07:46:08 INFO - PROCESS | 11323 | 07:46:11 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:46:11 INFO - PROCESS | 11323 | RSS: Main: 218411008 07:46:11 INFO - PROCESS | 11323 | 07:46:14 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:46:15 INFO - PROCESS | 11323 | RSS: Main: 219643904 07:46:15 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | Cycle 1(1): loaded http://localhost:46180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46180/tests/kraken/driver.html?testName=ai-astar) 07:46:17 INFO - PROCESS | 11323 | RSS: Main: 265719808 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | __start_tp_report 07:46:17 INFO - PROCESS | 11323 | _x_x_mozilla_page_load 07:46:17 INFO - PROCESS | 11323 | _x_x_mozilla_page_load_details 07:46:17 INFO - PROCESS | 11323 | |i|pagename|runs| 07:46:17 INFO - PROCESS | 11323 | |0;ai-astar;113;110;113;114;116;114;114;113;115;114 07:46:17 INFO - PROCESS | 11323 | |1;audio-beat-detection;162;133;152;217;132;163;166;130;198;133 07:46:17 INFO - PROCESS | 11323 | |2;audio-dft;161;159;160;161;161;161;161;160;159;161 07:46:17 INFO - PROCESS | 11323 | |3;audio-fft;75;76;78;156;76;75;77;74;131;76 07:46:17 INFO - PROCESS | 11323 | |4;audio-oscillator;92;93;153;92;93;92;121;92;93;121 07:46:17 INFO - PROCESS | 11323 | |5;imaging-gaussian-blur;116;116;116;117;116;116;117;116;116;116 07:46:17 INFO - PROCESS | 11323 | |6;imaging-darkroom;145;147;146;146;146;145;147;145;146;146 07:46:17 INFO - PROCESS | 11323 | |7;imaging-desaturate;94;95;95;94;95;94;95;94;94;94 07:46:17 INFO - PROCESS | 11323 | |8;json-parse-financial;69;68;69;68;68;69;68;68;68;68 07:46:17 INFO - PROCESS | 11323 | |9;json-stringify-tinderbox;65;65;65;64;66;64;64;65;65;66 07:46:17 INFO - PROCESS | 11323 | |10;stanford-crypto-aes;82;89;82;83;82;83;83;83;167;84 07:46:17 INFO - PROCESS | 11323 | |11;stanford-crypto-ccm;134;133;130;133;134;139;128;131;148;133 07:46:17 INFO - PROCESS | 11323 | |12;stanford-crypto-pbkdf2;177;179;183;180;179;179;175;177;176;175 07:46:17 INFO - PROCESS | 11323 | |13;stanford-crypto-sha256-iterative;69;69;69;68;71;67;69;67;67;67 07:46:17 INFO - PROCESS | 11323 | __end_tp_report 07:46:17 INFO - PROCESS | 11323 | __start_cc_report 07:46:17 INFO - PROCESS | 11323 | _x_x_mozilla_cycle_collect,2100 07:46:17 INFO - PROCESS | 11323 | __end_cc_report 07:46:17 INFO - PROCESS | 11323 | __startTimestamp1462977977362__endTimestamp 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | ------- Summary: start ------- 07:46:17 INFO - PROCESS | 11323 | Number of tests: 14 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.66 07:46:17 INFO - PROCESS | 11323 | Values: 113.0 110.0 113.0 114.0 116.0 114.0 114.0 113.0 115.0 114.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:162.50 stddev:29.68 (18.3%) stddev-sans-first:31.46 07:46:17 INFO - PROCESS | 11323 | Values: 162.0 133.0 152.0 217.0 132.0 163.0 166.0 130.0 198.0 133.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 07:46:17 INFO - PROCESS | 11323 | Values: 161.0 159.0 160.0 161.0 161.0 161.0 161.0 160.0 159.0 161.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#3] audio-fft Cycles:10 Average:89.40 Median:76.00 stddev:29.14 (38.3%) stddev-sans-first:30.43 07:46:17 INFO - PROCESS | 11323 | Values: 75.0 76.0 78.0 156.0 76.0 75.0 77.0 74.0 131.0 76.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:92.00 stddev:20.86 (22.7%) stddev-sans-first:21.66 07:46:17 INFO - PROCESS | 11323 | Values: 92.0 93.0 153.0 92.0 93.0 92.0 121.0 92.0 93.0 121.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:46:17 INFO - PROCESS | 11323 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 116.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:46:17 INFO - PROCESS | 11323 | Values: 145.0 147.0 146.0 146.0 146.0 145.0 147.0 145.0 146.0 146.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:46:17 INFO - PROCESS | 11323 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 07:46:17 INFO - PROCESS | 11323 | Values: 69.0 68.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 07:46:17 INFO - PROCESS | 11323 | Values: 65.0 65.0 65.0 64.0 66.0 64.0 64.0 65.0 65.0 66.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:83.00 stddev:26.50 (31.9%) stddev-sans-first:27.87 07:46:17 INFO - PROCESS | 11323 | Values: 82.0 89.0 82.0 83.0 82.0 83.0 83.0 83.0 167.0 84.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:133.50 stddev:5.62 (4.2%) stddev-sans-first:5.96 07:46:17 INFO - PROCESS | 11323 | Values: 134.0 133.0 130.0 133.0 134.0 139.0 128.0 131.0 148.0 133.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:179.00 stddev:2.49 (1.4%) stddev-sans-first:2.62 07:46:17 INFO - PROCESS | 11323 | Values: 177.0 179.0 183.0 180.0 179.0 179.0 175.0 177.0 176.0 175.0 07:46:17 INFO - PROCESS | 11323 | 07:46:17 INFO - PROCESS | 11323 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 07:46:17 INFO - PROCESS | 11323 | Values: 69.0 69.0 69.0 68.0 71.0 67.0 69.0 67.0 67.0 67.0 07:46:17 INFO - PROCESS | 11323 | -------- Summary: end -------- 07:46:17 INFO - PROCESS | 11323 | 07:46:18 INFO - TEST-INFO | 11323: exit 0 07:46:18 INFO - TEST-OK | kraken | took 65073ms 07:46:18 INFO - SUITE-END | took 1184s 07:46:18 INFO - Completed test suite (00:19:44) 07:46:18 INFO - javascript benchmark 07:46:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.211697549223, 2691.017778510844, 2720.251930719053, 2722.754952054315, 2734.753872151507, 4749.145153872301, 4791.472937976824, 4791.976040119795, 4870.318155458234, 4936.3829521309835, 4670.462896766873, 4716.080364328957, 4732.10090082884, 4770.904581908359, 4779.545943135406, 4341.2836881914445, 4406.118776244748, 4431.202383570972, 4461.308497182942, 4592.058627981272, 4524.502304746492, 4541.65937554683, 4545.045540436512, 4569.97175635481, 4603.355530225755, 4313.072689371768, 4315.654747620214, 4359.869203923888, 4363.367311739812, 4386.34204869269, 4341.6526677865695, 4412.051408947092, 4426.535213802536, 4427.203103441379, 4461.107778444291, 4445.177642136183, 4459.710118842265, 4466.865994020184, 4469.3296005599095, 4508.481524624644, 4606.539346065367, 4629.560191781776, 4646.53534646536, 4769.809207631691, 4823.517648235148, 5133.050385678662, 5135.281060651511, 5164.948350516484, 5182.300389447414, 5187.688738675692, 5117.437081920985, 5123.257127716461, 5186.481351864821, 5191.0, 5202.375714914197, 4622.121796858653, 4788.569028787426, 4795.976020119877, 4830.468648448667, 4837.0, 5339.599530035263, 5340.626156169031, 5367.1412573988755, 5370.570354371641, 5390.272313237741, 5110.233464980282, 5147.227915812583, 5158.045761534128, 5159.7678104485385, 5161.612879034087, 4984.177610694267, 5069.518395752398, 5126.436092029874, 5203.089459344599, 5209.166533354645, 5123.820666276737, 5124.564412024945, 5147.6911385317, 5160.0, 5179.974100129475, 5092.083424983464, 5098.289915294819, 5100.56645185156, 5102.846914592568, 5150.124478838607, 4175.206710724952, 4209.410682504452, 4312.072904325585, 4322.265214913472, 4360.672949528798, 3725.403935370328, 3763.736538442283, 3792.7724336539895, 3800.1639639279865, 3827.75119617224, 4396.670249731283, 4404.07514421975, 4405.757683327448, 4405.867823965286, 4451.1765323415275, 4921.2864134700985, 5034.672746271481, 5137.357830271216, 5150.665206761549, 5202.76587553561, 4338.8047537860875, 4348.391225228471, 4360.345948107809, 4397.890052748643, 4403.625691816232, 4502.482214545304, 4535.750533720677, 4536.047430039663, 4545.477270113913, 4588.88527786808, 4716.551927566876, 4758.76206189696, 4764.904701905943, 4812.975935120302, 4853.927191092066, 5155.742212889416, 5172.094883395315, 5177.275181474522, 5181.248718935658, 5218.191180367049, 4855.393075865517, 4868.513148685103, 4868.926966095582, 4869.878253043702, 4917.1149193145575, 4979.850604481871, 5014.398272207359, 5076.36545431821, 5079.060373830853, 5091.719955402488, 5150.433452320317, 5165.380154381498, 5168.3539557555305, 5169.741512924414, 5178.559822414986, 4998.950010499849, 4999.700017998932, 5009.073321435546, 5010.5240002199735, 5036.445990941067, 4852.223644216909, 4888.291197776373, 4894.314795928644, 4899.951000489949, 4942.6293028023765, 4802.399700037496, 4843.467218606021, 4880.682755620874, 4881.048195601824, 4882.95117048825, 4917.631177661761, 4926.433460151985, 4931.0, 4966.404031516096, 4975.0, 4727.220008698526, 4755.500672429345, 4756.9524304756505, 4949.82675606352, 4993.775280112331], "value": 4703.1529304847645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6849348611521, 604.5194070713782, 607.2773399654413, 607.726523064621, 618.292055596342, 40772.38841417377, 42280.57719422805, 42373.78813105934, 42379.78810105945, 46316.0, 41332.58667413325, 41745.58254417455, 41753.16493670125, 41771.37342939858, 41781.16437671245, 7528.0, 7751.6124193790365, 7760.0, 7891.28978391946, 8046.637901294456, 7726.497777644463, 10029.147522460564, 10317.0, 10330.7417314567, 10719.35683858967, 10352.327098738559, 10354.326968747007, 10357.689269321932, 10358.482075896212, 10362.067413932744, 7681.0, 10145.644902428416, 10211.438370889598, 10214.336068155546, 10221.89778102217, 9695.806083878282, 9790.608375664964, 10074.597016119347, 10081.143102836268, 10086.9495652522, 40504.59495405038, 41004.0, 41117.79441102775, 41126.177476450604, 41203.0, 3286.0, 3346.5147553604593, 3664.193877346979, 3725.590185079639, 4091.9386209206887, 29564.260893477836, 30085.849570752223, 30162.54756178637, 30328.526639517742, 30938.0, 3199.808011519293, 3237.4172648923186, 3271.8364081795817, 3315.0717799016315, 3383.644717304672, 255918.0, 256890.0, 257295.0, 257349.0, 258677.0, 60813.83082438042, 61287.08069378963, 61305.38694612997, 61352.38647613556, 61399.38600614026, 36547.81726091352, 37549.0, 37661.05847353838, 38963.80518097391, 38985.6101438982, 13928.721425571432, 13984.510542130976, 14047.719045619031, 14057.297135143202, 14076.788848167285, 10798.78402431947, 11416.42917854104, 11544.249623774427, 11603.477843497063, 11826.467808948619, 20279.0, 20378.388648340573, 20415.693764593543, 20479.180832766524, 20628.58742825135, 7475.439342049368, 7561.848763024709, 7620.0, 7652.47468335448, 7775.650095745705, 845.4420082745481, 996.8165539196209, 1084.8426978088132, 1090.5201711247184, 1104.861892263467, 28172.0, 28193.0, 28712.425751484854, 28939.85530072336, 28972.710272897424, 998.8202123617673, 1027.5941003303653, 1064.0583083970741, 1091.7216109892086, 1096.7258185453636, 14797.408103675732, 15293.311800968982, 15359.462418815288, 15737.213139342986, 15746.76379854303, 357872.0, 359906.0, 360731.0, 362152.0, 362214.0, 51753.0, 52013.219801703, 52013.47986520162, 52189.47810521846, 52416.73791631017, 1159.2291126401017, 1184.3722826901583, 1256.7737807194792, 1279.7952327627536, 1311.5278499740086, 27002.864985674947, 29346.853265733534, 29997.850010749808, 30381.0, 30544.0, 43063.56936430596, 43433.34849977316, 43511.0, 43694.34458483189, 43697.344539832564, 276466.0, 276474.0, 276684.0, 277877.0, 278419.0, 23294.534109318058, 26066.0, 26259.343516412242, 27256.0, 27274.727252727218, 43699.12601747883, 43783.562164377945, 44171.337429937936, 44520.55479445294, 44818.55181448144, 35396.646033539335, 35851.82074089613, 36722.26555468822, 36804.631953680124, 36857.63142368542, 36222.0, 36434.8178259107, 36552.81723591365, 36675.633243667224, 36891.0, 36270.4559431614, 36469.81765091157, 37320.62679373172, 37385.0, 37386.43920341143, 30786.0, 32245.838770805996, 32873.50689739608, 33025.0, 33183.0, 25349.493010139326, 25768.742312577386, 25819.870900645376, 25896.0, 26046.08838690637], "value": 18391.166486615315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.3208833002295, 383.7045474984264, 385.4757529759527, 387.36085458992676, 403.6589082225518, 15885.364585416584, 17155.399561015365, 17958.281668733252, 18010.189541470634, 18079.819201807994, 17039.14804259788, 17352.0, 17548.348408375405, 17831.73252401215, 17889.0, 5089.312942752727, 5220.634555581111, 5224.503672151159, 5252.737363131847, 5294.391145018314, 3696.5194524711883, 3851.826667799956, 4046.453728746611, 5998.580099393044, 6033.607815492001, 5921.348651648315, 6023.126646636235, 6054.394560543955, 6068.120122582223, 6074.908876366858, 6037.0642550404755, 6068.757249710006, 6074.544409169308, 6075.058365953284, 6080.452759251689, 3388.220709236865, 3547.5388199534154, 3551.485034669984, 3579.677828995377, 4973.751312434364, 20772.79227207739, 20949.0, 21078.78921210799, 21211.893940530354, 21284.467888302763, 2004.5589970206531, 2019.5153163240864, 2047.9692804607944, 2215.4461384653837, 2627.0805218173678, 6437.485001199892, 6477.125588045601, 6481.675916204171, 12349.259044457362, 13254.933725331312, 1796.5418818201406, 1805.702059160237, 1835.7062869940746, 1878.953026174343, 1884.9340273090377, 68041.65979170123, 69267.30732692659, 69826.30173698299, 70229.0, 71559.0, 9333.953330233306, 9593.184579310837, 9784.902150978542, 10326.070653641209, 10340.500375479296, 13385.464581416829, 13478.528251511347, 13481.0, 13495.190288582717, 13499.392527336293, 7259.745908893164, 7278.308560686726, 7351.742689005859, 7423.888641670379, 7466.925330746732, 7113.53762005468, 7136.215016348197, 7188.137423509108, 7288.453365997465, 7295.234000429985, 6261.123442718023, 6319.431251187323, 6347.96826015867, 6416.7433302668305, 6418.486521078303, 1710.4270069526847, 1741.1555395633109, 1741.5965966965507, 1791.9462416127537, 1807.1416077363147, 851.9148085191431, 882.1134759566722, 914.9908500915038, 947.5830634520927, 1000.9399436033862, 16770.496885093467, 17032.403865864635, 17261.827381726274, 17309.65380692379, 17652.382166624106, 896.8654701794652, 928.4150984879483, 936.3258453913172, 948.7533241357158, 963.4749061761357, 9700.90299097014, 10069.848952265722, 10222.744431389276, 10247.77026756794, 10257.199144489134, 291985.0, 410581.0, 425165.0, 426355.0, 427789.0, 60955.0, 72052.0, 72164.63917680379, 73335.26664733284, 73611.63194184101, 896.3143195455482, 941.4868896451451, 1003.6487229469773, 1004.382304882492, 1007.8387458006683, 15763.0, 15819.762703559225, 15947.920260398623, 16184.352625894833, 16249.10629915366, 35000.82499587486, 35153.64846351606, 35303.470447943815, 35414.739978304904, 35808.820955895055, 49006.26490602715, 50540.0, 50562.49437505578, 51197.744011279705, 51361.74319128381, 6658.067870498037, 7081.0, 7298.379637730853, 7827.295543401121, 8058.838823223386, 7328.303811137934, 11024.228304018963, 11964.401779911144, 12018.639440816789, 12304.138710290194, 10539.104176145114, 10556.102731267621, 10573.577056917637, 10625.681229563126, 10717.0, 10563.20775941792, 10593.629222977159, 10599.205059620404, 10614.427947251066, 10624.415657138932, 7192.820179495555, 10742.140628749838, 10912.127029837753, 10925.0, 11074.778504430027, 7359.889601655872, 7382.151052629017, 7408.925910740823, 7513.248675132661, 7544.09470863478, 8958.68644597436, 10718.19613529004, 10855.2401331906, 10930.070943969851, 10971.615993440191], "value": 8335.571592211594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.9935500322497, 1524.992375038125, 1562.1876624155439, 1727.9136043197846, 1896.1656870976778, 7549.660265288061, 7942.046954365477, 7958.24396682315, 8178.754637360874, 8189.140140285273, 7914.445988780788, 8093.352531797457, 8097.311728503069, 8098.51408915464, 8104.554249516289, 1916.3867562380044, 1985.2158397433004, 1991.273185287367, 2275.055851821492, 2328.592496313147, 2026.2806703620224, 2272.4318920269934, 2338.205010296499, 2338.8422730748302, 2357.316378250314, 2171.457135716071, 2209.8232141428725, 2216.1024784962037, 2232.48652809853, 2236.027328112268, 1860.55346716787, 2162.7729088445644, 2166.1876796201504, 2171.4679903423603, 2172.945676358104, 2118.152738904435, 2183.4213933307688, 2186.256672731279, 2198.373463562877, 2208.6024515587187, 7885.408594355389, 7943.324817390529, 7945.761627151137, 7956.164602716689, 8000.9199908000755, 4576.199165146086, 4665.650076244261, 4669.2062349400685, 4691.601213896823, 4705.788239529229, 2739.356251280947, 2830.0519326025806, 2897.768178545711, 2908.7527560157414, 2908.956365654517, 883.9779005524849, 889.8121008453722, 916.2990312411011, 917.6833992272656, 926.8424367857481, 10489.213309001856, 10501.842472362921, 10534.78930421395, 10537.262391632512, 10537.78924421515, 4363.978180109079, 4497.347884556721, 4554.544545545486, 4607.585317321457, 4610.216263235258, 9071.818563628822, 9097.0, 9105.0, 9118.133777291147, 9119.224865886341, 4865.051314993613, 4923.827666031743, 4933.605311575066, 4939.209726443752, 4947.035328110984, 3448.3103379324234, 3812.4853144825647, 4334.5882141196535, 4432.689711720213, 4452.465704115527, 3777.4522694209186, 3876.3604005339366, 3878.7284890057426, 3908.2769687607883, 3911.159100793343, 1263.0653316545875, 1277.916935399196, 1288.7358091591202, 1291.541502766523, 1305.5822136916286, 903.4172958441768, 907.1472815553359, 925.000998921177, 931.1433481197315, 937.329809186435, 5611.186377975171, 5611.803586874522, 5774.335951365647, 5781.364049954502, 5891.440313170242, 912.8950170730318, 945.7210123013728, 957.1959553974694, 962.1869520255512, 973.2068364283086, 3758.586555478895, 3826.3877779555696, 3833.865814696472, 3944.6647035001774, 3950.8734822559977, 9624.855627165458, 9926.851097233548, 10030.799384012425, 10167.237457190593, 10172.338797978256, 9887.0, 9902.960189180176, 9918.355306905029, 9921.851172232422, 10050.899491004997, 7504.437167212481, 7628.0464941882265, 7646.770596882103, 7676.961615191888, 7679.2320767923875, 5329.467053294795, 5364.785408583613, 5460.0, 5577.051901176728, 5661.150827375926, 8786.472811631322, 8801.647934082564, 9233.169014788702, 9261.72214833556, 9398.295127865575, 9228.169464748205, 9358.204552613104, 9405.623775048922, 9501.857472138061, 9517.666881659386, 6055.273367195965, 7158.355747982707, 7407.888881666887, 7414.703411863465, 7418.146913105062, 7244.275572442713, 7286.125664920243, 7293.635318233961, 7466.178720340867, 7479.513831600929, 6727.360900714424, 6855.897161542481, 6872.62200578973, 6943.444524438134, 6969.686364113526, 6780.966095169492, 6809.114815074008, 6829.385355318045, 6883.3116688330765, 6894.482913781386, 6153.4154255345675, 6317.684115794284, 6556.18047744032, 6565.704543295467, 6693.397594216349, 4711.764411779466, 4734.502877197982, 4760.143174228672, 4772.403449568804, 4863.805447782191, 4802.111609352281, 4811.27830825365, 4838.225883858566, 4867.853964381075, 4915.090708218991], "value": 4276.204685800715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.817400472714, 303.3160223695566, 312.7451127331224, 316.0471179394127, 316.90492852144354, 4630.606398456135, 4719.150552900476, 4760.452852822834, 4813.411574180521, 4853.5389138031915, 4534.410526631534, 4704.435467743867, 4725.14947309485, 4728.787204575794, 4783.306420569015, 3758.7368884178118, 3798.9620103798884, 3803.7147213958924, 3804.4673745675627, 3840.577536471, 3645.8359373828107, 3703.4444833274956, 3814.5803961564343, 3818.961810381902, 3829.7893615851117, 3761.586225515191, 3781.773093614392, 3782.678472329855, 3798.8670396536127, 3801.923961520768, 3782.0, 3790.65884070435, 3791.4502397152532, 3791.848326066982, 3793.1275806564367, 3396.439587468065, 3399.0285634332026, 3400.0989737719524, 3403.4384326586082, 3424.503447000171, 4454.13144436835, 4540.772961351952, 4541.750203738793, 4542.250528662767, 4567.33773602829, 4292.570742925714, 4294.57054294568, 4304.80628371724, 4325.762083085429, 4338.284183109783, 4895.265710143472, 4960.627952903546, 4970.676906001098, 4972.801087956477, 5003.849884503471, 3462.774919630216, 3648.5256916600674, 3656.6526180012856, 3660.359437098497, 3668.559772827251, 5169.81905633301, 5208.453112423217, 5221.425643179247, 5222.921656175123, 5225.634205605609, 3802.657760801541, 3809.5999920008553, 3820.541535015816, 3822.3119838429348, 3838.347480928249, 3792.412176112707, 3833.5208098987628, 3853.325668008087, 3880.980595097063, 3917.843286268517, 4288.8284468620905, 4298.3552467130185, 4302.139572085595, 4324.978375108167, 4327.8485253016, 4958.975205123951, 4977.278294647256, 4985.354832905133, 5010.69935803853, 5011.423686276052, 1231.7228623559627, 1265.4685032286461, 1266.290877108822, 1276.2087505746497, 1287.3305880941857, 913.7258822353267, 938.8075444533854, 939.6899023322287, 950.3537594435712, 954.3367359685091, 4371.5082403029965, 4385.0, 4392.0, 4403.581659742319, 4437.267850804581, 4911.582515486224, 5110.872228194251, 5124.026434977342, 5124.66689665178, 5147.227915812583, 4350.825277175145, 4366.410534577855, 4366.868993930188, 4375.912481750347, 4382.255016647114, 2693.205504376214, 2699.0, 2701.9324516887236, 2711.9322016949736, 2716.6009505104885, 4633.7683115844075, 4774.116788394158, 4787.521247875185, 4807.326974223612, 4955.554000140005, 5341.973290133525, 5362.835926803127, 5373.543248823816, 5377.3816011159215, 5377.462253774669, 4888.291197776373, 4917.213245880642, 4922.8769280768265, 4933.76655836041, 4935.654504184673, 4968.950310496849, 5144.9163088949035, 5169.4830516948, 5174.0, 5178.249153872743, 5046.116929537243, 5090.490950905028, 5104.310918026019, 5107.41264754558, 5136.844210052708, 4942.7034377936, 4959.528844759742, 4971.776270067783, 4998.225275082368, 4999.275105109811, 3520.5071290018905, 3710.2394009227505, 3726.5155529780955, 3736.5889752127787, 3758.4362345648374, 5123.538881500683, 5176.7152806596, 5182.6113041521285, 5219.0, 5222.582193424441, 4933.802647894044, 4992.850214493571, 5017.448080711046, 5026.637480384214, 5106.336176297058, 4761.000189960008, 4774.450938142019, 5021.698698078127, 5031.899362012812, 5037.647364684583, 4847.248676455155, 4938.012397520582, 4942.332785073969, 4962.975185124052, 4988.9251661225835, 5017.724025178651, 5058.647728806123, 5097.413797413345, 5122.436531981553, 5161.509656582619, 4795.256735206049, 4969.850904472872, 4988.301637770643, 5001.399832020181, 5067.6199285053035], "value": 3814.4518255445023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.1174082599729, 680.8570200257946, 682.4676752133338, 716.0905649824726, 736.5580651609032, 11865.466054027567, 12044.0, 12557.183783054095, 12765.170263932861, 12776.872231277684, 13460.394282257297, 14126.505572304972, 14287.14277143372, 14295.0, 14306.141631502118, 692.5429216716968, 855.7389996051202, 874.1215078845751, 889.244142478891, 890.1143362354467, 879.4151888993812, 880.106691707917, 882.7042940614901, 882.7131182365724, 882.8940527136721, 923.852183650616, 925.3383830561147, 925.773185569533, 925.9953700231489, 926.0369216015335, 723.1502983993812, 874.9650013999433, 905.9139381758722, 908.7955210077746, 919.5264438814016, 676.3034074902858, 677.2617846547287, 677.6340775980964, 678.047343482408, 678.7658257901016, 11322.660320190407, 11356.375399353032, 11393.487293071832, 11400.144989125765, 11412.258203216765, 11167.553297868075, 11406.315621062762, 11446.484908179153, 11626.418679066013, 11723.824142637868, 11250.831237531444, 11332.093432525378, 11379.317240965485, 11433.771324573545, 11523.48144333507, 4118.052847845012, 4118.464599602063, 4151.937720934188, 4184.19238492973, 4269.210196113729, 46049.76975115103, 46079.308810367875, 46207.306890396336, 46432.07135857264, 46789.53210467886, 8546.914530854736, 8704.216620504185, 8770.38607297483, 8777.517236551923, 8823.294136469067, 15998.600034999217, 16156.515304540882, 16169.59576010609, 16171.110588917723, 16195.838041619669, 6399.968000159969, 6443.871122577522, 6627.204735431779, 6656.600603963778, 6703.966480167568, 3519.3137338218803, 3544.964550354515, 3781.9810900945317, 3795.6773674237447, 3817.408301713239, 2658.41514866729, 2736.3022429280404, 2737.534619114755, 2743.82165159268, 2746.780257579389, 522.589767032885, 529.7483695244728, 534.1613666543567, 536.1689381458723, 544.3413469701705, 555.1035078348439, 589.5048159546002, 614.4991831657185, 623.7847942459844, 634.1724050114552, 8009.399295052895, 8314.833703326021, 8362.247397734232, 8412.453190542596, 8520.531370774543, 526.2579762534807, 531.9015982043335, 539.5090467674476, 541.4937033873263, 546.1507356061284, 3762.2663580602066, 3797.3354662933875, 3837.6162383761957, 3843.238175035435, 3847.9038024049623, 49003.26495102576, 51484.0, 51531.0, 51583.226251606255, 51699.0, 44226.33660495095, 44353.334699979525, 44923.77538112288, 46907.29639055417, 47442.0, 41835.163296733896, 42175.57824421778, 42563.14873702508, 42760.3585946211, 43018.0, 7271.0, 7336.229695881855, 7350.632468376667, 7436.628168591657, 7492.51298665585, 29053.854730727056, 29605.0, 29821.552676709434, 29889.10332690023, 30345.848270758506, 35255.82372088123, 37478.25043499169, 38000.61999379971, 38086.23827523489, 38559.228815424096, 9227.630894764134, 9326.160645541933, 9372.67195648149, 9466.715998520056, 9480.668176613786, 10084.949575252076, 10173.796524069625, 10258.538365773707, 11720.355380454157, 11882.524699011943, 9408.529573521433, 9694.739683841055, 11383.886161138282, 11813.82279265829, 11845.289282643069, 11333.716657083638, 11357.659270221906, 11749.823752643546, 11910.642680719593, 11974.880251197377, 11213.102951763676, 11241.943790280997, 11374.431278435879, 11632.141022251828, 11804.232724872856, 9599.808003840024, 9777.560009799434, 9927.602895884083, 9933.400725456486, 10022.849657255292, 10041.347312424668, 10102.065698261795, 10254.23093267993, 10263.281570290008, 10265.538050787882], "value": 5971.104680825178, "unit": "score"}], "name": "dromaeo_css", "value": 6423.2515446702955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 114.0, 116.0, 114.0, 114.0, 113.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 152.0, 217.0, 132.0, 163.0, 166.0, 130.0, 198.0, 133.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 156.0, 76.0, 75.0, 77.0, 74.0, 131.0, 76.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 92.0, 93.0, 92.0, 121.0, 92.0, 93.0, 121.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 89.0, 82.0, 83.0, 82.0, 83.0, 83.0, 83.0, 167.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 130.0, 133.0, 134.0, 139.0, 128.0, 131.0, 148.0, 133.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 183.0, 180.0, 179.0, 179.0, 175.0, 177.0, 176.0, 175.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 71.0, 67.0, 69.0, 67.0, 67.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1588.3, "alertThreshold": 2.0}]} 07:46:18 INFO - Return code: 0 07:46:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:46:18 ERROR - # TBPL SUCCESS # 07:46:18 INFO - Running post-action listener: _resource_record_post_action 07:46:18 INFO - ##### 07:46:18 INFO - ##### Finished run-tests step (success) 07:46:18 INFO - ##### 07:46:18 INFO - Running post-run listener: _resource_record_post_run 07:46:19 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536100864; Read time: 20; Write time: 484444 07:46:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241774592; Read time: 0; Write time: 266260 07:46:19 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293728256; Read time: 20; Write time: 218184 07:46:19 INFO - Running post-run listener: _upload_blobber_files 07:46:19 INFO - Blob upload gear active. 07:46:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:46:19 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 07:46:19 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:46:19 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:46:20 INFO - (blobuploader) - INFO - Open directory for files ... 07:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:20 INFO - (blobuploader) - INFO - Done attempting. 07:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:21 INFO - (blobuploader) - INFO - Done attempting. 07:46:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:46:21 INFO - Return code: 0 07:46:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:46:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:46:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/700611f1728a54a6dc1ac45d1a397a58feb4dc7e1095d9290b2c7ffa39014554b762dcdace3dd62e1fa647a00eac5bd914cc75648b0462558833f087a3dd10a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f187d8e66696ff294e907032c0b9937f8886396ae7f8163adb61e3f9908c27ab3fa51980ebd59dc31fb9767a2c1fb21347aaa7a06e017b2efad55707338a54"} 07:46:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:46:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:46:21 INFO - Contents: 07:46:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/700611f1728a54a6dc1ac45d1a397a58feb4dc7e1095d9290b2c7ffa39014554b762dcdace3dd62e1fa647a00eac5bd914cc75648b0462558833f087a3dd10a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f187d8e66696ff294e907032c0b9937f8886396ae7f8163adb61e3f9908c27ab3fa51980ebd59dc31fb9767a2c1fb21347aaa7a06e017b2efad55707338a54"} 07:46:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:46:21 INFO - Copying logs to upload dir... 07:46:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:46:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.472860 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-11 07:46:21.600377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 07:46:21.604148) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/700611f1728a54a6dc1ac45d1a397a58feb4dc7e1095d9290b2c7ffa39014554b762dcdace3dd62e1fa647a00eac5bd914cc75648b0462558833f087a3dd10a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f187d8e66696ff294e907032c0b9937f8886396ae7f8163adb61e3f9908c27ab3fa51980ebd59dc31fb9767a2c1fb21347aaa7a06e017b2efad55707338a54"} build_url:https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/Y0qKhMGrRGSmP8T10tNOWA/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/Firefox-Non-PGO/sha512/700611f1728a54a6dc1ac45d1a397a58feb4dc7e1095d9290b2c7ffa39014554b762dcdace3dd62e1fa647a00eac5bd914cc75648b0462558833f087a3dd10a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f187d8e66696ff294e907032c0b9937f8886396ae7f8163adb61e3f9908c27ab3fa51980ebd59dc31fb9767a2c1fb21347aaa7a06e017b2efad55707338a54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 07:46:21.629044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:46:21.629414) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462976686.734360-618344180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 07:46:21.713409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 07:46:21.713870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 07:46:21.714353) ========= ========= Total master_lag: 0.17 =========