builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1461330155.82 results: success (0) buildid: 20160422045408 builduid: 7b93c0d50626428ab80cd01e87445501 revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:35.821381) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:35.821860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:35.822163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:36.035114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:36.035486) ========= 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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:02:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-04-22 06:02:37 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.356488 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:36.405457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:36.405788) ========= 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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019500 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:36.456728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:02:36.457125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4ca15e44f0b59c06d35b776320cb149e2422a2fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4ca15e44f0b59c06d35b776320cb149e2422a2fc --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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:02:37,209 truncating revision to first 12 chars 2016-04-22 06:02:37,209 Setting DEBUG logging. 2016-04-22 06:02:37,209 attempt 1/10 2016-04-22 06:02:37,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4ca15e44f0b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:02:38,520 unpacking tar archive at: fx-team-4ca15e44f0b5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.643186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:02:38.113803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:38.114378) ========= script_repo_revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:38.115117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:38.115591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:02:38.127253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:02:38.127864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:02:38 INFO - MultiFileLogger online at 20160422 06:02:38 in /builds/slave/test 06:02:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:02:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:38 INFO - {'append_to_log': False, 06:02:38 INFO - 'base_work_dir': '/builds/slave/test', 06:02:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:02:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:38 INFO - 'branch': 'Fx-Team-Non-PGO', 06:02:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:38 INFO - 'config_files': ('talos/linux_config.py',), 06:02:38 INFO - 'default_actions': ('clobber', 06:02:38 INFO - 'read-buildbot-config', 06:02:38 INFO - 'download-and-extract', 06:02:38 INFO - 'populate-webroot', 06:02:38 INFO - 'create-virtualenv', 06:02:38 INFO - 'install', 06:02:38 INFO - 'run-tests'), 06:02:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:38 INFO - 'download_minidump_stackwalk': True, 06:02:38 INFO - 'download_symbols': 'ondemand', 06:02:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:38 INFO - 'installer_path': 'installer.exe', 06:02:38 INFO - 'log_level': 'info', 06:02:38 INFO - 'log_name': 'talos', 06:02:38 INFO - 'log_to_console': True, 06:02:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:02:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:02:38 INFO - 'opt_config_files': (), 06:02:38 INFO - 'pip_index': False, 06:02:38 INFO - 'sps_profile': False, 06:02:38 INFO - 'sps_profile_interval': 0, 06:02:38 INFO - 'suite': 'dromaeojs', 06:02:38 INFO - 'system_bits': '32', 06:02:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:38 INFO - 'title': 'talos-linux64-ix-002', 06:02:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:38 INFO - 'use_talos_json': True, 06:02:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:38 INFO - 'work_dir': 'build'} 06:02:38 INFO - ##### 06:02:38 INFO - ##### Running clobber step. 06:02:38 INFO - ##### 06:02:38 INFO - Running pre-action listener: _resource_record_pre_action 06:02:38 INFO - Running main action method: clobber 06:02:38 INFO - rmtree: /builds/slave/test/build 06:02:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:39 INFO - Running post-action listener: _resource_record_post_action 06:02:39 INFO - ##### 06:02:39 INFO - ##### Running read-buildbot-config step. 06:02:39 INFO - ##### 06:02:39 INFO - Running pre-action listener: _resource_record_pre_action 06:02:39 INFO - Running main action method: read_buildbot_config 06:02:39 INFO - Using buildbot properties: 06:02:39 INFO - { 06:02:39 INFO - "project": "", 06:02:39 INFO - "product": "firefox", 06:02:39 INFO - "script_repo_revision": "production", 06:02:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:02:39 INFO - "repository": "", 06:02:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:02:39 INFO - "buildid": "20160422045408", 06:02:39 INFO - "pgo_build": "False", 06:02:39 INFO - "basedir": "/builds/slave/test", 06:02:39 INFO - "buildnumber": 1584, 06:02:39 INFO - "slavename": "talos-linux64-ix-002", 06:02:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:02:39 INFO - "platform": "ubuntu64_hw", 06:02:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:02:39 INFO - "branch": "fx-team", 06:02:39 INFO - "repo_path": "integration/fx-team", 06:02:39 INFO - "revision": "4ca15e44f0b59c06d35b776320cb149e2422a2fc", 06:02:39 INFO - "stage_platform": "linux64", 06:02:39 INFO - "builduid": "7b93c0d50626428ab80cd01e87445501", 06:02:39 INFO - "slavebuilddir": "test" 06:02:39 INFO - } 06:02:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:02:39 INFO - Running post-action listener: _resource_record_post_action 06:02:39 INFO - ##### 06:02:39 INFO - ##### Running download-and-extract step. 06:02:39 INFO - ##### 06:02:39 INFO - Running pre-action listener: _resource_record_pre_action 06:02:39 INFO - Running main action method: download_and_extract 06:02:39 INFO - mkdir: /builds/slave/test/build/tests 06:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:39 INFO - https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:02:41 INFO - Downloaded 1361 bytes. 06:02:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:02:41 INFO - Using the following test package requirements: 06:02:41 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:02:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:02:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:02:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'jsshell-linux-x86_64.zip'], 06:02:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:02:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:02:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:02:41 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:02:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:02:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:02:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:41 INFO - https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:02:42 INFO - Downloaded 22281373 bytes. 06:02:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:02:43 INFO - Return code: 0 06:02:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:02: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')]} 06:02:43 INFO - https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:02:45 INFO - Downloaded 22281373 bytes. 06:02:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:02:46 INFO - Return code: 0 06:02: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')]} 06:02:46 INFO - https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:02:47 INFO - Downloaded 10845952 bytes. 06:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:02:47 INFO - Return code: 0 06:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:47 INFO - https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:02:49 INFO - Downloaded 54724927 bytes. 06:02:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:02:49 INFO - mkdir: /builds/slave/test/properties 06:02:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:49 INFO - Contents: 06:02:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:02:50 INFO - Running post-action listener: _resource_record_post_action 06:02:50 INFO - Running post-action listener: set_extra_try_arguments 06:02:50 INFO - ##### 06:02:50 INFO - ##### Running populate-webroot step. 06:02:50 INFO - ##### 06:02:50 INFO - Running pre-action listener: _resource_record_pre_action 06:02:50 INFO - Running main action method: populate_webroot 06:02:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:50 INFO - '--tppagecycles', 06:02:50 INFO - '7'], 06:02:50 INFO - 'tests': ['tsvgm']}}, 06:02:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['damp', 'tps']}, 06:02:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'tests': ['damp', 'tps']}, 06:02:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['dromaeo_dom']}, 06:02:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['a11yr', 06:02:50 INFO - 'ts_paint', 06:02:50 INFO - 'tpaint', 06:02:50 INFO - 'sessionrestore', 06:02:50 INFO - 'sessionrestore_no_auto_restore', 06:02:50 INFO - 'tabpaint']}, 06:02:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['tsvgx', 06:02:50 INFO - 'tsvgr_opacity', 06:02:50 INFO - 'tart', 06:02:50 INFO - 'tscrollx', 06:02:50 INFO - 'cart']}, 06:02:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:50 INFO - 'tsvgr_opacity', 06:02:50 INFO - 'tart', 06:02:50 INFO - 'tscrollx', 06:02:50 INFO - 'cart']}, 06:02:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'talos_options': ['--disable-e10s'], 06:02:50 INFO - 'tests': ['tp5o']}, 06:02:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'tests': ['tp5o']}, 06:02:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'talos_options': ['--disable-e10s', 06:02:50 INFO - '--xperf_path', 06:02:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:50 INFO - 'tests': ['tp5n']}, 06:02:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:50 INFO - 'talos_options': ['--xperf_path', 06:02:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:50 INFO - 'tests': ['tp5n']}}, 06:02:50 INFO - 'talos.zip': {'path': '', 06:02:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:50 INFO - Running post-action listener: _resource_record_post_action 06:02:50 INFO - ##### 06:02:50 INFO - ##### Running create-virtualenv step. 06:02:50 INFO - ##### 06:02:50 INFO - Running pre-action listener: _resource_record_pre_action 06:02:50 INFO - Running main action method: create_virtualenv 06:02:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:50 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 06:02:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:50 INFO - Using real prefix '/usr' 06:02:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:52 INFO - Installing pip.................done. 06:02:52 INFO - Return code: 0 06:02:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:02:52 INFO - Using env: {'DISPLAY': ':0', 06:02:52 INFO - 'HOME': '/home/cltbld', 06:02:52 INFO - 'LANG': 'en_US.UTF-8', 06:02:52 INFO - 'LANGUAGE': 'en_US:en', 06:02:52 INFO - 'LOGNAME': 'cltbld', 06:02:52 INFO - 'MAIL': '/var/mail/cltbld', 06:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:52 INFO - 'MOZ_NO_REMOTE': '1', 06:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:52 INFO - 'NO_EM_RESTART': '1', 06:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:52 INFO - 'PWD': '/builds/slave/test', 06:02:52 INFO - 'SHELL': '/bin/bash', 06:02:52 INFO - 'SHLVL': '1', 06:02:52 INFO - 'TERM': 'linux', 06:02:52 INFO - 'TMOUT': '86400', 06:02:52 INFO - 'USER': 'cltbld', 06:02:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:52 INFO - '_': '/tools/buildbot/bin/python'} 06:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:52 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 06:02:52 INFO - Cleaning up... 06:02:52 INFO - Return code: 0 06:02:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:02:52 INFO - Using env: {'DISPLAY': ':0', 06:02:52 INFO - 'HOME': '/home/cltbld', 06:02:52 INFO - 'LANG': 'en_US.UTF-8', 06:02:52 INFO - 'LANGUAGE': 'en_US:en', 06:02:52 INFO - 'LOGNAME': 'cltbld', 06:02:52 INFO - 'MAIL': '/var/mail/cltbld', 06:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:52 INFO - 'MOZ_NO_REMOTE': '1', 06:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:52 INFO - 'NO_EM_RESTART': '1', 06:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:52 INFO - 'PWD': '/builds/slave/test', 06:02:52 INFO - 'SHELL': '/bin/bash', 06:02:52 INFO - 'SHLVL': '1', 06:02:52 INFO - 'TERM': 'linux', 06:02:52 INFO - 'TMOUT': '86400', 06:02:52 INFO - 'USER': 'cltbld', 06:02:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:52 INFO - '_': '/tools/buildbot/bin/python'} 06:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:53 INFO - Downloading/unpacking psutil>=0.7.1 06:02:53 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 06:02:53 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 06:02:53 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 06:02:53 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 06:02:53 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 06:02:53 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 06:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:55 INFO - Installing collected packages: psutil 06:02:55 INFO - Running setup.py install for psutil 06:02:55 INFO - building 'psutil._psutil_linux' extension 06:02:55 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 06:02:55 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 06:02:55 INFO - building 'psutil._psutil_posix' extension 06:02:55 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 06:02:55 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 06:02:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:55 INFO - Successfully installed psutil 06:02:55 INFO - Cleaning up... 06:02:55 INFO - Return code: 0 06:02:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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', '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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:02: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:02: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 mozsystemmonitor==0.0.0 06:02:55 INFO - Using env: {'DISPLAY': ':0', 06:02:55 INFO - 'HOME': '/home/cltbld', 06:02:55 INFO - 'LANG': 'en_US.UTF-8', 06:02:55 INFO - 'LANGUAGE': 'en_US:en', 06:02:55 INFO - 'LOGNAME': 'cltbld', 06:02:55 INFO - 'MAIL': '/var/mail/cltbld', 06:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:55 INFO - 'MOZ_NO_REMOTE': '1', 06:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:55 INFO - 'NO_EM_RESTART': '1', 06:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:55 INFO - 'PWD': '/builds/slave/test', 06:02:55 INFO - 'SHELL': '/bin/bash', 06:02:55 INFO - 'SHLVL': '1', 06:02:55 INFO - 'TERM': 'linux', 06:02:55 INFO - 'TMOUT': '86400', 06:02:55 INFO - 'USER': 'cltbld', 06:02:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:55 INFO - '_': '/tools/buildbot/bin/python'} 06:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:02:57 INFO - Installing collected packages: mozsystemmonitor 06:02:57 INFO - Running setup.py install for mozsystemmonitor 06:02:57 INFO - Successfully installed mozsystemmonitor 06:02:57 INFO - Cleaning up... 06:02:57 INFO - Return code: 0 06:02:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:02:57 INFO - Using env: {'DISPLAY': ':0', 06:02:57 INFO - 'HOME': '/home/cltbld', 06:02:57 INFO - 'LANG': 'en_US.UTF-8', 06:02:57 INFO - 'LANGUAGE': 'en_US:en', 06:02:57 INFO - 'LOGNAME': 'cltbld', 06:02:57 INFO - 'MAIL': '/var/mail/cltbld', 06:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:57 INFO - 'MOZ_NO_REMOTE': '1', 06:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:57 INFO - 'NO_EM_RESTART': '1', 06:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:57 INFO - 'PWD': '/builds/slave/test', 06:02:57 INFO - 'SHELL': '/bin/bash', 06:02:57 INFO - 'SHLVL': '1', 06:02:57 INFO - 'TERM': 'linux', 06:02:57 INFO - 'TMOUT': '86400', 06:02:57 INFO - 'USER': 'cltbld', 06:02:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:57 INFO - '_': '/tools/buildbot/bin/python'} 06:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:03:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:03:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:00 INFO - Downloading docopt-0.6.1.tar.gz 06:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:03:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:03:00 INFO - Running setup.py install for blobuploader 06:03:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:03:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:03:00 INFO - Running setup.py install for requests 06:03:01 INFO - Running setup.py install for docopt 06:03:01 INFO - Successfully installed blobuploader requests docopt 06:03:01 INFO - Cleaning up... 06:03:01 INFO - Return code: 0 06:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:01 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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:03:01 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 06:03:01 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 06:03:01 INFO - Using env: {'DISPLAY': ':0', 06:03:01 INFO - 'HOME': '/home/cltbld', 06:03:01 INFO - 'LANG': 'en_US.UTF-8', 06:03:01 INFO - 'LANGUAGE': 'en_US:en', 06:03:01 INFO - 'LOGNAME': 'cltbld', 06:03:01 INFO - 'MAIL': '/var/mail/cltbld', 06:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:01 INFO - 'MOZ_NO_REMOTE': '1', 06:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:01 INFO - 'NO_EM_RESTART': '1', 06:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:01 INFO - 'PWD': '/builds/slave/test', 06:03:01 INFO - 'SHELL': '/bin/bash', 06:03:01 INFO - 'SHLVL': '1', 06:03:01 INFO - 'TERM': 'linux', 06:03:01 INFO - 'TMOUT': '86400', 06:03:01 INFO - 'USER': 'cltbld', 06:03:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:01 INFO - '_': '/tools/buildbot/bin/python'} 06:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:01 INFO - Running setup.py (path:/tmp/pip-fCdDzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:01 INFO - Running setup.py (path:/tmp/pip-dUfeXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:01 INFO - Running setup.py (path:/tmp/pip-w1eC06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:01 INFO - Running setup.py (path:/tmp/pip-1EbXaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:01 INFO - Running setup.py (path:/tmp/pip-u3aOZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:01 INFO - Running setup.py (path:/tmp/pip-9xGmFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:01 INFO - Running setup.py (path:/tmp/pip-YzQCQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:02 INFO - Running setup.py (path:/tmp/pip-HstHhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:02 INFO - Running setup.py (path:/tmp/pip-OP_TO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:02 INFO - Running setup.py (path:/tmp/pip-RvT0Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:02 INFO - Running setup.py (path:/tmp/pip-lcccVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:02 INFO - Running setup.py (path:/tmp/pip-__pEob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:02 INFO - Running setup.py (path:/tmp/pip-fE_y0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:02 INFO - Running setup.py (path:/tmp/pip-6wizat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:02 INFO - Running setup.py (path:/tmp/pip-drCrYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:02 INFO - Running setup.py (path:/tmp/pip-jTClRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:02 INFO - Running setup.py (path:/tmp/pip-4hvzhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:03:02 INFO - Running setup.py install for manifestparser 06:03:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:03:02 INFO - Running setup.py install for mozcrash 06:03:02 INFO - Running setup.py install for mozdebug 06:03:03 INFO - Running setup.py install for mozdevice 06:03:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for mozfile 06:03:03 INFO - Running setup.py install for mozhttpd 06:03:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for mozinfo 06:03:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for mozInstall 06:03:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for mozleak 06:03:03 INFO - Running setup.py install for mozlog 06:03:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for moznetwork 06:03:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:03:03 INFO - Running setup.py install for mozprocess 06:03:04 INFO - Running setup.py install for mozprofile 06:03:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:03:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:03:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:03:04 INFO - Running setup.py install for mozrunner 06:03:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:03:04 INFO - Running setup.py install for mozscreenshot 06:03:04 INFO - Running setup.py install for moztest 06:03:04 INFO - Running setup.py install for mozversion 06:03:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:03:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:03:04 INFO - Cleaning up... 06:03:04 INFO - Return code: 0 06:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:04 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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:03:04 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 06:03:04 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 06:03:04 INFO - Using env: {'DISPLAY': ':0', 06:03:04 INFO - 'HOME': '/home/cltbld', 06:03:04 INFO - 'LANG': 'en_US.UTF-8', 06:03:04 INFO - 'LANGUAGE': 'en_US:en', 06:03:04 INFO - 'LOGNAME': 'cltbld', 06:03:04 INFO - 'MAIL': '/var/mail/cltbld', 06:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:04 INFO - 'MOZ_NO_REMOTE': '1', 06:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:04 INFO - 'NO_EM_RESTART': '1', 06:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:04 INFO - 'PWD': '/builds/slave/test', 06:03:04 INFO - 'SHELL': '/bin/bash', 06:03:04 INFO - 'SHLVL': '1', 06:03:04 INFO - 'TERM': 'linux', 06:03:04 INFO - 'TMOUT': '86400', 06:03:04 INFO - 'USER': 'cltbld', 06:03:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:04 INFO - '_': '/tools/buildbot/bin/python'} 06:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:04 INFO - Running setup.py (path:/tmp/pip-EaO7C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:04 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)) 06:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:04 INFO - Running setup.py (path:/tmp/pip-88abl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:04 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)) 06:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:04 INFO - Running setup.py (path:/tmp/pip-jLm7dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:05 INFO - Running setup.py (path:/tmp/pip-oM8prM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:05 INFO - Running setup.py (path:/tmp/pip-btijU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:05 INFO - Running setup.py (path:/tmp/pip-OlRfUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:05 INFO - Running setup.py (path:/tmp/pip-7QN_GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:05 INFO - Running setup.py (path:/tmp/pip-IVMfrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:05 INFO - Running setup.py (path:/tmp/pip-7koUmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:05 INFO - Running setup.py (path:/tmp/pip-5O4nGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:05 INFO - Running setup.py (path:/tmp/pip-VrMinO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:05 INFO - Running setup.py (path:/tmp/pip-cjYih6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:05 INFO - Running setup.py (path:/tmp/pip-2wSomi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:05 INFO - Running setup.py (path:/tmp/pip-MHKufe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:05 INFO - Running setup.py (path:/tmp/pip-wob52Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:05 INFO - Running setup.py (path:/tmp/pip-hE90_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:05 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)) 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:05 INFO - Running setup.py (path:/tmp/pip-FHOI6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:06 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)) 06:03:06 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)) 06:03:06 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)) 06:03:06 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)) 06:03:06 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)) 06:03:06 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)) 06:03:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:07 INFO - Downloading blessings-1.6.tar.gz 06:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:03:07 INFO - Installing collected packages: blessings 06:03:07 INFO - Running setup.py install for blessings 06:03:08 INFO - Successfully installed blessings 06:03:08 INFO - Cleaning up... 06:03:08 INFO - Return code: 0 06:03:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:08 INFO - Reading from file tmpfile_stdout 06:03:08 INFO - Current package versions: 06:03:08 INFO - argparse == 1.2.1 06:03:08 INFO - blessings == 1.6 06:03:08 INFO - blobuploader == 1.2.4 06:03:08 INFO - docopt == 0.6.1 06:03:08 INFO - manifestparser == 1.1 06:03:08 INFO - mozInstall == 1.12 06:03:08 INFO - mozcrash == 0.17 06:03:08 INFO - mozdebug == 0.1 06:03:08 INFO - mozdevice == 0.48 06:03:08 INFO - mozfile == 1.2 06:03:08 INFO - mozhttpd == 0.7 06:03:08 INFO - mozinfo == 0.9 06:03:08 INFO - mozleak == 0.1 06:03:08 INFO - mozlog == 3.1 06:03:08 INFO - moznetwork == 0.27 06:03:08 INFO - mozprocess == 0.22 06:03:08 INFO - mozprofile == 0.28 06:03:08 INFO - mozrunner == 6.11 06:03:08 INFO - mozscreenshot == 0.1 06:03:08 INFO - mozsystemmonitor == 0.0 06:03:08 INFO - moztest == 0.7 06:03:08 INFO - mozversion == 1.4 06:03:08 INFO - psutil == 3.1.1 06:03:08 INFO - requests == 1.2.3 06:03:08 INFO - wsgiref == 0.1.2 06:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:08 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')]} 06:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:08 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')]} 06:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:08 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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:03:08 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 06:03:08 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 06:03:08 INFO - Using env: {'DISPLAY': ':0', 06:03:08 INFO - 'HOME': '/home/cltbld', 06:03:08 INFO - 'LANG': 'en_US.UTF-8', 06:03:08 INFO - 'LANGUAGE': 'en_US:en', 06:03:08 INFO - 'LOGNAME': 'cltbld', 06:03:08 INFO - 'MAIL': '/var/mail/cltbld', 06:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:08 INFO - 'MOZ_NO_REMOTE': '1', 06:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:08 INFO - 'NO_EM_RESTART': '1', 06:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:08 INFO - 'PWD': '/builds/slave/test', 06:03:08 INFO - 'SHELL': '/bin/bash', 06:03:08 INFO - 'SHLVL': '1', 06:03:08 INFO - 'TERM': 'linux', 06:03:08 INFO - 'TMOUT': '86400', 06:03:08 INFO - 'USER': 'cltbld', 06:03:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:08 INFO - '_': '/tools/buildbot/bin/python'} 06:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 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)) 06:03:08 INFO - Cleaning up... 06:03:08 INFO - Return code: 0 06:03:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:03:08 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')]} 06:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:08 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')]} 06:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:08 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 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:03:08 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 06:03:08 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 06:03:08 INFO - Using env: {'DISPLAY': ':0', 06:03:08 INFO - 'HOME': '/home/cltbld', 06:03:08 INFO - 'LANG': 'en_US.UTF-8', 06:03:08 INFO - 'LANGUAGE': 'en_US:en', 06:03:08 INFO - 'LOGNAME': 'cltbld', 06:03:08 INFO - 'MAIL': '/var/mail/cltbld', 06:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:08 INFO - 'MOZ_NO_REMOTE': '1', 06:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:08 INFO - 'NO_EM_RESTART': '1', 06:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:08 INFO - 'PWD': '/builds/slave/test', 06:03:08 INFO - 'SHELL': '/bin/bash', 06:03:08 INFO - 'SHLVL': '1', 06:03:08 INFO - 'TERM': 'linux', 06:03:08 INFO - 'TMOUT': '86400', 06:03:08 INFO - 'USER': 'cltbld', 06:03:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:08 INFO - '_': '/tools/buildbot/bin/python'} 06:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:08 INFO - Downloading/unpacking jsonschema 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:03:10 INFO - Downloading/unpacking functools32 (from jsonschema) 06:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:03:10 INFO - warning: no files found matching '*.txt' 06:03:10 INFO - no previously-included directories found matching 'build' 06:03:10 INFO - no previously-included directories found matching 'dist' 06:03:10 INFO - no previously-included directories found matching '.git*' 06:03:10 INFO - Installing collected packages: jsonschema, functools32 06:03:10 INFO - Running setup.py install for functools32 06:03:11 INFO - warning: no files found matching '*.txt' 06:03:11 INFO - no previously-included directories found matching 'build' 06:03:11 INFO - no previously-included directories found matching 'dist' 06:03:11 INFO - no previously-included directories found matching '.git*' 06:03:11 INFO - Successfully installed jsonschema functools32 06:03:11 INFO - Cleaning up... 06:03:11 INFO - Return code: 0 06:03:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77de80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, '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-1461330136.976483-1746752305', '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 06:03: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', 'flake8'] in /builds/slave/test/build 06:03: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 flake8 06:03:11 INFO - Using env: {'DISPLAY': ':0', 06:03:11 INFO - 'HOME': '/home/cltbld', 06:03:11 INFO - 'LANG': 'en_US.UTF-8', 06:03:11 INFO - 'LANGUAGE': 'en_US:en', 06:03:11 INFO - 'LOGNAME': 'cltbld', 06:03:11 INFO - 'MAIL': '/var/mail/cltbld', 06:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:11 INFO - 'MOZ_NO_REMOTE': '1', 06:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:11 INFO - 'NO_EM_RESTART': '1', 06:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:11 INFO - 'PWD': '/builds/slave/test', 06:03:11 INFO - 'SHELL': '/bin/bash', 06:03:11 INFO - 'SHLVL': '1', 06:03:11 INFO - 'TERM': 'linux', 06:03:11 INFO - 'TMOUT': '86400', 06:03:11 INFO - 'USER': 'cltbld', 06:03:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:11 INFO - '_': '/tools/buildbot/bin/python'} 06:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:11 INFO - Downloading/unpacking flake8 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:03:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:03:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:03:13 INFO - no previously-included directories found matching 'docs/_build' 06:03:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:03:14 INFO - Running setup.py install for pep8 06:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:03:14 INFO - no previously-included directories found matching 'docs/_build' 06:03:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:03:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:03:14 INFO - Cleaning up... 06:03:14 INFO - Return code: 0 06:03:14 INFO - Running post-action listener: _resource_record_post_action 06:03:14 INFO - Running post-action listener: _start_resource_monitoring 06:03:14 INFO - Starting resource monitoring. 06:03:14 INFO - ##### 06:03:14 INFO - ##### Running install step. 06:03:14 INFO - ##### 06:03:14 INFO - Running pre-action listener: _resource_record_pre_action 06:03:14 INFO - Running main action method: install 06:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:14 INFO - Reading from file tmpfile_stdout 06:03:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:03:14 INFO - Reading from file tmpfile_stdout 06:03:14 INFO - Output received: 06:03:14 INFO - Usage: mozinstall [options] installer 06:03:14 INFO - Options: 06:03:14 INFO - -h, --help show this help message and exit 06:03:14 INFO - -d DEST, --destination=DEST 06:03:14 INFO - Directory to install application into. [default: 06:03:14 INFO - "/builds/slave/test"] 06:03:14 INFO - --app=APP Application being installed. [default: firefox] 06:03:14 INFO - mkdir: /builds/slave/test/build/application 06:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:03:30 INFO - Reading from file tmpfile_stdout 06:03:30 INFO - Output received: 06:03:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:03:30 INFO - Running post-action listener: _resource_record_post_action 06:03:30 INFO - ##### 06:03:30 INFO - ##### Running run-tests step. 06:03:30 INFO - ##### 06:03:30 INFO - Running pre-action listener: _resource_record_pre_action 06:03:30 INFO - Running main action method: run_tests 06:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:03:30 INFO - Python 2.7.3 06:03:30 INFO - Return code: 0 06:03:30 INFO - grabbing minidump binary from tooltool 06:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:03:30 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0410>, '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 0x23b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:03:30 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 06:03:30 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 06:03:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:03:30 INFO - Return code: 0 06:03:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:03:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:03:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:03:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:03:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:03:31 INFO - Return code: 0 06:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.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 06:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.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 06:03:31 INFO - Using env: {'DISPLAY': ':0', 06:03:31 INFO - 'HOME': '/home/cltbld', 06:03:31 INFO - 'LANG': 'en_US.UTF-8', 06:03:31 INFO - 'LANGUAGE': 'en_US:en', 06:03:31 INFO - 'LOGNAME': 'cltbld', 06:03:31 INFO - 'MAIL': '/var/mail/cltbld', 06:03:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:03:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:31 INFO - 'MOZ_NO_REMOTE': '1', 06:03:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:31 INFO - 'NO_EM_RESTART': '1', 06:03:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:31 INFO - 'PWD': '/builds/slave/test', 06:03:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:03:31 INFO - 'SHELL': '/bin/bash', 06:03:31 INFO - 'SHLVL': '1', 06:03:31 INFO - 'TERM': 'linux', 06:03:31 INFO - 'TMOUT': '86400', 06:03:31 INFO - 'USER': 'cltbld', 06:03:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461330136.976483-1746752305', 06:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:31 INFO - '_': '/tools/buildbot/bin/python'} 06:03:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.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 06:03:31 INFO - mozversion application_buildid: 20160422045408 06:03:31 INFO - mozversion application_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 06:03:31 INFO - mozversion application_display_name: Nightly 06:03:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:03:31 INFO - mozversion application_name: Firefox 06:03:31 INFO - mozversion application_remotingname: firefox 06:03:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:03:31 INFO - mozversion application_vendor: Mozilla 06:03:31 INFO - mozversion application_version: 48.0a1 06:03:31 INFO - mozversion platform_buildid: 20160422045408 06:03:31 INFO - mozversion platform_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 06:03:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:03:31 INFO - mozversion platform_version: 48.0a1 06:03:31 INFO - using testdate: 1461330211 06:03:31 INFO - actual date: 1461330211 06:03:31 INFO - starting webserver on 'localhost:53249' 06:03:31 INFO - SUITE-START | Running 2 tests 06:03:31 INFO - TEST-START | dromaeo_css 06:03:31 INFO - operating with platform_type : linux_ 06:03:31 INFO - Initialising browser for dromaeo_css test... 06:03:31 INFO - TEST-INFO | started process 3028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwSXYY/profile http://localhost:53249/getInfo.html) 06:03:35 INFO - PROCESS | 3028 | __metrics Screen width/height:1600/1200 06:03:35 INFO - PROCESS | 3028 | colorDepth:24 06:03:35 INFO - PROCESS | 3028 | Browser inner width/height: 1024/697 06:03:35 INFO - PROCESS | 3028 | __metrics 06:03:36 ERROR - PROCESS | 3028 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:03:37 INFO - TEST-INFO | 3028: exit 0 06:03:37 INFO - Browser initialized. 06:03:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:03:37 INFO - TEST-INFO | started process 3106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwSXYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:49 INFO - PROCESS | 3106 | RSS: Main: 154882048 06:03:49 INFO - PROCESS | 3106 | 06:04:41 INFO - PROCESS | 3106 | 1461330281085 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] 06:06:52 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53249/tests/dromaeo/cssquery-ext.html) 06:06:53 INFO - PROCESS | 3106 | RSS: Main: 265773056 06:06:53 INFO - PROCESS | 3106 | 06:09:56 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-ext.html (next: http://localhost:53249/tests/dromaeo/cssquery-jquery.html) 06:09:56 INFO - PROCESS | 3106 | RSS: Main: 234217472 06:09:56 INFO - PROCESS | 3106 | 06:12:58 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53249/tests/dromaeo/cssquery-mootools.html) 06:12:59 INFO - PROCESS | 3106 | RSS: Main: 236421120 06:12:59 INFO - PROCESS | 3106 | 06:16:01 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53249/tests/dromaeo/cssquery-prototype.html) 06:16:02 INFO - PROCESS | 3106 | RSS: Main: 229097472 06:16:02 INFO - PROCESS | 3106 | 06:19:05 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53249/tests/dromaeo/cssquery-yui.html) 06:19:05 INFO - PROCESS | 3106 | RSS: Main: 215121920 06:19:05 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-yui.html (next: http://localhost:53249/tests/dromaeo/cssquery-dojo.html) 06:22:08 INFO - PROCESS | 3106 | RSS: Main: 293183488 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | __start_tp_report 06:22:08 INFO - PROCESS | 3106 | _x_x_mozilla_page_load 06:22:08 INFO - PROCESS | 3106 | _x_x_mozilla_page_load_details 06:22:08 INFO - PROCESS | 3106 | |i|pagename|runs| 06:22:08 INFO - PROCESS | 3106 | |0;dojo.html;2597.259780962426;2679.423923856372;2684.1544913352304;2703.716109808469;2719.225020869052;4505.684602077856;4609.216433206355;4658.440987081551;4681.6020638245745;4686.90626187476;4684.227102528079;4725.40932383452;4728.4798672146035;4772.928406073912;4775.973165769359;4243.766592837401;4259.190753756776;4267.637250833667;4332.7833608319615;4406.889827754316;4309.698321117523;4356.1723272578265;4371.169477799224;4380.649548036149;4423.491298500681;4172.18642364739;4253.3619957006695;4267.701260911737;4285.678574106923;4361.498427680794;4329.1558146161515;4340.934885976713;4343.2399330117105;4345.891352716208;4394.758288294142;4316.870493885157;4322.481302243751;4325.913481730379;4364.759938203398;4369.912601747979;4459.063596644709;4527.253003254459;4555.726656400627;4637.489876113625;4657.767111644438;5015.197568389077;5015.749212539395;5018.096742586333;5020.447750747415;5056.570191533724;5029.7736601853;5036.84889453317;5044.9747751261375;5048.368953880765;5070.163423035195;4597.080583883237;4670.3461515387535;4758.0246049559755;4759.000609871897;4760.33355330254;5121.119648519434;5137.717425541631;5144.408393034849;5149.356330458692;5203.557697595671;4934.210526315772;4935.7532123393685;4937.382827146606;4939.333190019302;4992.550670439605;4784.114938736276;4985.451600323961;5028.396592408862;5069.44236134025;5091.541761241432;4984.37695288089;5018.121828679967;5018.974905125451;5022.196448568285;5036.043151801146;4991.151504244287;4997.750112494361;5000.2749601307605;5007.023630392038;5059.797608095709;4151.91696166075;4202.663786897041;4217.198732240864;4218.8523401681405;4263;3725.3294407006456;3742.700583953277;3744.700423966076;3767.171222331083;3783.659470647655;4359.346098085312;4363.192809330284;4368.213721530092;4396.384506169139;4421.690481666253;4940.7035577865445;4969.776360063805;5053.898922021613;5068.366454193226;5078.619103567247;4345.521992580813;4362.236608593484;4380.123975204971;4408.889777755582;4409.338599210144;4533.841315554006;4537.6143027842345;4540.6821522493765;4540.6821522493765;4586.908261834745;4640.327152562927;4709.270063140219;4724.9763751180335;4762.738049407316;4798.1123492154065;4898.167311557115;4914.729689867092;4919.655624106278;4924.089043526959;4987.12725273083;4630.536946305342;4632.953670463252;4633.467151277646;4666.043461090536;4703.647226458098;4799.712017278975;4854.417469903634;4868;4956.405231372259;4962.181240095344;5016.698998060128;5024.145895197752;5043.52086551777;5053.620978426559;5099.949000509948;4899.779509921991;4903.509649035068;4910.803567857246;4913.238448040559;4957.82647607332;4776.546228108463;4843.4430040545785;4910.975445122752;4940.011997600566;4971.950280497149;4828.589569886599;4860.3195552621955;4874;4923.803047878045;4928.778204980713;4826.806927722992;4956.281339205867;4967.82612608557;4987.202047672355;5038.748062596929;4774.522547745337;4810.086083644096;4818.349522814516;4853.417589889236;4866.853994380174 06:22:08 INFO - PROCESS | 3106 | |1;ext.html;574.8160588611644;594.1355327997761;606.251279669608;610.6610830988805;616.014376996805;26196.73803261969;26822;34284.828575857086;35368.46947295793;35493.46759798605;36692.44961325582;37438.43842342367;37493.25013499728;37526;37564.81217593915;7540;7782.9610851945945;7784.688612455495;7785.182555831641;7796.142424333347;7610.277023682769;7718.382529397635;7736.690532378698;7742.032245969254;7745.3029227369525;7895.447318687694;7953.244441778022;7962.044554653449;7962.044554653449;7962.800929976768;7866.488678235896;7910.564918929428;7928.167542408022;7929.207079292025;7933.801654958615;7799.5710235937;7821.882671759929;7913.525188488651;7921.287084162395;7921.603919803987;36645.816770916244;37019;37167.628323716686;37321.066973325615;37333.25333493315;2791.9441611167867;3072.0476652237653;3400.2009527760956;3439.174598096464;3490.930181396358;24688;24782.504349912902;25002.249932502054;25011.249662510152;25416.237512874643;3400.4389275769468;3402.1834759657504;3601.7838929664304;3611.7652352596997;3625.401808701561;232672;233484.83257583773;234206.65793342018;234413;234538;32564.348713025607;33482.8325858374;33511.497327540106;48201.517984820406;49268;32010;32050.519242211387;32072.839635801673;32186.517202241987;32261.838690806395;12248.632541023784;12539.498420063277;12553;12554;12559.058070644738;9400;9433;9439.103285187895;9454.385464944757;9460;8090.514569125754;8098.068722097034;8121.593920303962;8135.389845761473;8194.590270486571;3126.4059828632944;3151.73210277129;3164.5095010273444;3186.745060395163;3222.5971753530807;910.4400793512075;915.2449229385651;923.7644400677784;940.2330185957131;1025.9487025648689;26154;27406.862965685043;27585.448291034467;27805;27868.860655696593;825.9421840471109;915.8900931888217;963.0417734354362;966.4732720667254;996.9960379636982;13129.606111816469;13819.930900345435;14005.299735013412;14032.508862189774;14115.364808583638;342564;343476;346502;349420;351532;47636;48345.516544834805;48454.51545484571;48465.75767121212;48494.27258591124;1185.3523602192959;1233.0505510756846;1261.1550261324935;1263.551439239057;1328.5350127455313;25375.746242537338;26816.32959176036;26830.865845670647;27126;27428.177154685392;38487.422688659135;38927.41608875926;38934.41598376083;38977.80511097427;39098.609013909496;233988;239797;240277;240416;241138;22181;22921.426964326027;23054;23068.653970190797;24524.264272071865;35512.112197195274;35784.821075894455;36275.45586816147;36514.8174259127;36753.81623091974;33990.15024624404;35971.46042809307;36183.819080904424;36791;36824.26351473009;30800;31314.373712526078;31499.84250078735;31737;31747.365052698355;31091.84454077715;31248.375032499676;31633.5254971171;31979.84010079935;32202.03393898093;28241;28717.856410717814;28883.422331552832;30701.385972279983;31102.533461997635;22727;23210.883945580164;23234;23429;23546.764532354457 06:22:08 INFO - PROCESS | 3106 | |2;jquery.html;374.59356598091085;376.6572419098621;380.54144755569536;380.969522438205;389.72913824891714;15323.233838308082;16630.501084967455;17670.734938975893;17693.91153044236;17706.114694265285;15744.606384840385;16163.353465861352;16310.429134980279;16730.41443549476;16730.58173545662;5055.949440505585;5197.688138711671;5224.033553792541;5225.216217567377;5229.529342359187;3633.5276414066266;5637.295338082739;5918.792842250522;5933.694587190833;5943.821685349447;5858;5886.676232807194;5886.793962211324;5912.113183022538;5913.763449462038;5843.123531470271;6015.849603759897;6034.30605480371;6045.667488288121;6054.394560543955;3278.1804548862783;3450.8447119879415;3459.0487615905577;3462.221000274943;4927.556519913225;19924.70112948307;20428.693569596468;20704.689429658567;20723.171073157057;20756.896215518977;1960.6764883794158;2030.4111807575784;2060.9690854637192;2301.9424514387106;2318.455163036702;8835.867461988075;9137.588808503633;9405.294602904809;9488;13118.803217951738;1754.3158168314367;1790.3733693207403;1854.2119599170298;1855.4804654696707;1861.720741888714;69178.30821691769;70359;70589;70878.29121708768;71432;10023.2482563808;10101.494925253708;10119.59521619127;10134.898651013544;10365.689029329133;14136.85863141376;14212;14298.57104286873;14300.141991480545;14300.499482518062;6608.438282745924;6704;6738.292479289702;6801.081853949752;6838.760643377458;5860.38465961068;6013.398660133952;6029.969850150809;6042.879142417127;6054.122152287981;4260.6378457830815;4306.397104405386;4323.718958267703;4421.159979603865;4429.15845989261;1753.298680527799;1814.8638852086146;1834.1562881074856;1839.3654189304668;1879.473747350744;810.9635066422026;858.9398742088118;861.0571424290392;893.2452077994085;928.7538802217417;15102;16219.918900405422;16582.66834663324;16600.83399166017;16781.91609041947;855.3242938078972;860.5654144656908;860.9483430994161;880.366136381804;887.4231749362966;9060.864087038699;9190.58642361082;9249.861252081224;9298.72103836886;9444.8583271251;405366;411343;411993;415261;419919;75915;77685;78079.60960195276;78311;78595;887.6893087419352;887.745952922855;896.0412358776047;898.883145191121;904.3579058868277;14209.644758881112;14256.857431425553;14470.638234044232;14607.050541714754;14917.179555124572;33053.834730826195;33417.16457088592;33872.3225535483;34005.48991765076;34198.290085496126;47382.76308618435;48858;48927.510724892294;48967.51032489629;48995.755021224664;7600.733974311093;7615.1242607098675;7643.197464266172;7750.186230445947;7824.921750782647;11164.720881978015;11437.428128593703;11445.713857153638;11448.885511144781;11670.70823229426;8426.073131955603;9204.98745138021;9554.378965367228;9557.569909354235;9936.900630993598;9353.251739860658;9707.466089365153;10077.445740484343;10144.79710405773;10145.746356340855;9037.954810225907;10075.395476271447;10446.216533759847;10537.841932370868;10820.783584328427;7572.129205141259;7629.160792312952;7739.032620922385;7817.5309481431295;8137.8372432552205;9744.317897747089;9886.555105020147;10164.33931794431;10460.372377657364;10686.198535109743 06:22:08 INFO - PROCESS | 3106 | |3;mootools.html;1085.1427372375824;1134.3987686526143;1143.9599614013512;1290.3032362524236;1677.6225349296403;7529.8870516942225;7780.183080776507;7781.494202876809;7840.215978402157;7846.254605812446;7637.427192960522;7774.0671119465605;7781.961090194541;7794.415418843581;7795;1968.3602829080605;2014.1540552967715;2017.2737814386883;2250.111206073604;2271.3526644906124;2259.9774002260015;2318.258157389636;2321.071571371448;2321.442853715105;2323.117215458132;2190.5618876224817;2191.1235505797727;2197.099189332374;2199.098369668436;2257.3792207143083;1950.5611237471596;2194.0455901682817;2253;2260.864348139117;2261.728592568902;2284;2300.3214051854743;2301.079568172744;2303.4011157099108;2303.953920921589;7580.241975802431;7644.770656880302;7649.273319034683;7657.349125324354;7666.501677391007;4590.60979816716;4727.810887564493;4732.739699316537;4732.763361831895;4733;2772.1129238643643;2921.6786153523094;2928.253295409657;2945.7348838604416;2947.1158652404406;871.324723339417;875.4353442029856;882.3779235638859;889.3907673243849;911.5396724654007;10661.893381066167;10711.625093121782;10716.785664286748;10758.623448179276;10765.892341076646;4370.628496577763;4483.058557702853;4496.505384407778;4515.706479078849;4520.095980803852;8319.916800832036;8366.748997530083;8373.07896131425;8393.202645748644;8405.243528082501;4689.62483001359;4715.221988371949;4728.929066064012;4731.526847315241;4735.550122738335;3618.782873027627;3903.9609603903596;4411;4415.139047885696;4419.491758447755;3317.8175200364212;3385.2213990781765;3444.7588668793446;3489.1102768793794;3510.350585141757;1049.454283772434;1085.647164671485;1089.591403223791;1097.434821067151;1102.972425689348;758.8558173947043;760.8517973637644;770.7957391291312;777.9105402878741;783.7570353190529;5005.724685142352;5047.899042019139;5075.111855425286;5117.437081920985;5124.385073791169;411.69903106184313;414.40325930659753;423.45585922090584;423.4833503126181;440.44064038670706;3293.275479394529;3430.2453460238708;3466.6360032196762;3471.149568355769;3485.9302813944087;9377.578008989612;9797.216222702167;9932.900670993342;9940.906500284962;9947.701568952943;9652.372595781393;9799.951000244953;9815.36200146988;9829.066238707312;9829.754256143653;7421.888671670037;7424.591647459441;7433.331000210007;7515.473916825769;7531.774046778605;5123.462036486116;5127.512886275797;5143.61422893277;5149.639525233198;5219.399769026611;8938.955305223692;8948.821023579621;9016.18854303116;9113.3165012623;9117.908820911705;8693.217610415093;8946.552672366226;9105.954470227607;9327.673531426368;9340.065993400605;6505.577137486048;6589.110470086477;6591.670416479253;6629.07192992991;6644.734210631714;6964.877204499902;7307.561546307238;7314.634268286671;7326.81682957909;7346.77959661211;6722.05891175226;6749.291324410866;6789.966050169717;6837.453003759787;6880.105586273752;6645.202575690754;6659.733610655713;6680.365365290289;6791.762288319885;6809.965950170217;6227;6287.937120628735;6307.085472606354;6319.52603554726;6323.430891219812;4338.717983331074;4374.21264172452;4442.844500442469;4474.015716542355;4476.037651904856;4355.368471571668;4372.431583894074;4526.185286648435;4534.342520334599;4551.47658019332 06:22:08 INFO - PROCESS | 3106 | |4;prototype.html;315.2717223214374;316.09438957387084;319.94880819068953;323.89959112675075;325.4045097471627;5022.773975171117;5071.797128114876;5090.236464530322;5125.948740512594;5132.512411320928;5076.416212135606;5079.415867175276;5085.567726743231;5089.541941225289;5109.233614957759;3751.831167597458;3855.363864962278;3859.1895701902636;3968.702347323948;4013.9197216055663;3994.8601798937043;3995.760254384746;4015.4339807475108;4016.2569924563904;4032.5362583302854;3742.195427982983;3959;3968.618828702784;3968.72218944674;3973.7615743055508;3838.888611263808;3969.4641223434755;3971.463852379921;3973.364261718126;3979.7413168143976;3505.1587618971516;3523.894283171509;3525.964740352589;3527.417976033951;3538.239278555123;4904.705717656952;4911;4915.066137433876;4921.704697718113;4929.112759703252;4253.2769429197115;4501.369808226851;4512.390827238313;4523.117991991563;4580.152671755703;5224.869378265574;5279.736013199325;5280.4422695304975;5282.7622756976025;5287.444818294062;3746.925061498782;3750.79370634615;3752.080740218664;3752.9437058444146;3761.360568703327;5345.679259244458;5564;5599.8880022399735;5600.691961942091;5627.2684551008515;3816.637419445148;3825.2923209206388;3841.9423708644395;3857.8263978121054;3868.0716628009077;3897.6686981606313;3916.96083039166;3917.353636649978;3919.6864250859862;3927.489426374553;4197.853075142355;4503.88740281489;4510.14307281622;4510.300903359985;4519.887002824956;5367.5169234769055;5384.865378365572;5391.137418013099;5391.649542779785;5423.972880135574;1356.959291221265;1373.3545233740126;1378.0904602961998;1378.696686728918;1380.289151087191;839.0644431458879;894.2488309819653;917.454114801692;920.1718453392001;947.0860619502214;4679.602233810097;4682.274247491644;4683.297505374221;4686.601638860667;4690.460597031385;5477.123660214346;5497.45025497447;5501.587380946445;5505.559555235572;5511.366192887789;4522.321651752263;4648.372469716613;4683.391159149289;4704.576588107018;4755.714657120584;2943.351723035107;2977.464056469813;2985.104468659437;2986.850657467118;2993.8802447902276;5230.320058392384;5238.895222095537;5249.897521520524;5262.421133675292;5271.551918086929;5512.91730624041;5695.45893140151;5714;5733.827985160452;5739.139129130664;5230.7384630769075;5232.607554433433;5244.292020577173;5245.501677340647;5248.448912864171;5445.809396671098;5571.721413929368;5573.191887176417;5602.831915042555;5603.8792241552665;5437.918431223614;5478.616496845342;5490.752916118704;5492.80775172867;5498.642588231752;5224.817131400535;5242.76407561653;5242.842714718565;5248.160294352885;5277.630565860353;3788.1389249687854;3870.96129038706;3894.3184942635494;3898.317794386028;3905.1018265798457;5537.197106419627;5543.722813859372;5578.916316255179;5580.414056524007;5592.888142237214;5344.732763361894;5365.275687782099;5365.436629153883;5390.838274851761;5404.702741349263;5091.1854103343285;5384.380796208487;5397.9190312144565;5419.182025346877;5423.972880135574;5058.696478211172;5313.54834839043;5328.280682107866;5333.839984800462;5346.572274218131;5246.422893481637;5398.40617532079;5467.507924286833;5470.53500452466;5480.287562616834;5276.445973172762;5281.15501519755;5292.04743146222;5294.729264976455;5322 06:22:08 INFO - PROCESS | 3106 | |5;yui.html;660.4518249852623;686.1937223762078;730.8757511223091;739.8964145019696;767.6315368623061;12201.694957626063;12594.748105037894;12612.936935315334;12659.177153485018;12670.683232919182;12498.500059997588;12559.874401255986;12568;12582.307973061477;12598.622041338751;620.9968950155243;745.8732015557341;780.3640033372811;780.9843803123935;781.413939545341;773.1225059557414;778.6807408962327;779.2713812585223;779.6218833865571;779.777763337449;659.5712786688642;817.2154731457807;818.3494122172887;819.4509678515409;819.848328059308;673.1316601583951;675.9290274521178;793.7658390774735;816.542736067798;817.9795505112361;602.1509671363357;602.2682440834408;602.5751844949344;602.6564858030924;602.8523011862078;12049.578264760692;12120.272783632921;12150.210236334698;12157.574484892986;12159.148859579833;11519.596814111466;11669.591564295293;12141.514339426412;12302;12318.384080796013;9824.950875245579;9867.16129129025;9911.355761875455;9921.40471571708;10052.64815731446;3184.601924759405;3240.902772916816;3267.787593806395;3326.900192994214;3358.580177477815;42155.367669484986;43638.56361436409;43742.56257437385;45098.32352514715;45572.3164152538;9657.22742180638;9689.370190937567;9720.319577629498;9758.658446954465;9918.553665085088;17032.2335494903;17104.05927673965;17260.568485787957;17336.65326693459;17343.392981245597;6913.1358580177475;7039.648017599099;7052.118485189351;7073.115860517435;7078.787636370917;3734.7012239020814;3750.1937083527173;3755.9061023474633;3767.246550689873;3811.8094095295123;2891.640928763478;2938.177310353062;2941.8529073546665;2942.735153836165;2947.0864032149675;484.69222044001606;503.509078648315;511.836212412032;521.6061873285645;523.374567391963;461.2366533387249;512.6744517231584;572.7479908840097;581.7236812514022;615.6829232945037;6983.406410455066;7537.200241888237;7558.622068896533;7577.810554736066;7767.262110099531;576.3429690153229;603.6016229288737;611.9479844213203;613.349849159892;614.1371373220633;3533.293341331744;3603.4955106285142;3605.8557657693923;3646.2889736501656;3663.157473781045;52108.47891521036;52171.73914130481;52338;52827;52984.20523692148;46107.077858442644;46433;46963.76518117456;47105;47386.763066184445;37845.243095138496;37894.62105378966;38948.46834955719;39116.804415977735;39442;7420.443466739908;7443.292887175709;7495.587742674205;7662.846743064996;7853.136155023057;25970.610440843026;26657.333566660214;26695.466090678467;27677.584836227874;28293.43413131767;33609.327813444084;35811.462828058124;36770.63229367672;36910.446343304335;37569;9486.241100711788;9613.951930240304;9750.366226195274;9814.852777208205;10070.244731645009;10473.423961681876;10534.209934255116;10562.524686388977;10973.451327433757;11296.49165787558;9012.967688136412;9433.386829856037;9897.25770567196;9923;10231.590736370461;9689.854652180364;10010.749731256778;10054.54754536033;10070.19438444908;10633.734156646145;10009;10377.740556486147;10717.624883129365;10724.463776810971;10764.461776910966;8099.190080991853;8146.2261085196815;8207.58962051907;8411.495310281403;8467;8226.177382261725;8355.289800367036;8537.786555336166;8720.563971801512;8773.824523509622 06:22:08 INFO - PROCESS | 3106 | __end_tp_report 06:22:08 INFO - PROCESS | 3106 | __start_cc_report 06:22:08 INFO - PROCESS | 3106 | _x_x_mozilla_cycle_collect,1018 06:22:08 INFO - PROCESS | 3106 | __end_cc_report 06:22:08 INFO - PROCESS | 3106 | __startTimestamp1461331328754__endTimestamp 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | ------- Summary: start ------- 06:22:08 INFO - PROCESS | 3106 | Number of tests: 6 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#0] dojo.html Cycles:165 Average:4640.84 Median:4772.93 stddev:475.82 (10.0%) stddev-sans-first:449.47 06:22:08 INFO - PROCESS | 3106 | Values: 2597.3 2679.4 2684.2 2703.7 2719.2 4505.7 4609.2 4658.4 4681.6 4686.9 4684.2 4725.4 4728.5 4772.9 4776.0 4243.8 4259.2 4267.6 4332.8 4406.9 4309.7 4356.2 4371.2 4380.6 4423.5 4172.2 4253.4 4267.7 4285.7 4361.5 4329.2 4340.9 4343.2 4345.9 4394.8 4316.9 4322.5 4325.9 4364.8 4369.9 4459.1 4527.3 4555.7 4637.5 4657.8 5015.2 5015.7 5018.1 5020.4 5056.6 5029.8 5036.8 5045.0 5048.4 5070.2 4597.1 4670.3 4758.0 4759.0 4760.3 5121.1 5137.7 5144.4 5149.4 5203.6 4934.2 4935.8 4937.4 4939.3 4992.6 4784.1 4985.5 5028.4 5069.4 5091.5 4984.4 5018.1 5019.0 5022.2 5036.0 4991.2 4997.8 5000.3 5007.0 5059.8 4151.9 4202.7 4217.2 4218.9 4263.0 3725.3 3742.7 3744.7 3767.2 3783.7 4359.3 4363.2 4368.2 4396.4 4421.7 4940.7 4969.8 5053.9 5068.4 5078.6 4345.5 4362.2 4380.1 4408.9 4409.3 4533.8 4537.6 4540.7 4540.7 4586.9 4640.3 4709.3 4725.0 4762.7 4798.1 4898.2 4914.7 4919.7 4924.1 4987.1 4630.5 4633.0 4633.5 4666.0 4703.6 4799.7 4854.4 4868.0 4956.4 4962.2 5016.7 5024.1 5043.5 5053.6 5099.9 4899.8 4903.5 4910.8 4913.2 4957.8 4776.5 4843.4 4911.0 4940.0 4972.0 4828.6 4860.3 4874.0 4923.8 4928.8 4826.8 4956.3 4967.8 4987.2 5038.7 4774.5 4810.1 4818.3 4853.4 4866.9 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#1] ext.html Cycles:180 Average:40869.85 Median:174970.59 stddev:73177.37 (41.8%) stddev-sans-first:73320.11 06:22:08 INFO - PROCESS | 3106 | Values: 574.8 594.1 606.3 610.7 616.0 26196.7 26822.0 34284.8 35368.5 35493.5 36692.4 37438.4 37493.3 37526.0 37564.8 7540.0 7783.0 7784.7 7785.2 7796.1 7610.3 7718.4 7736.7 7742.0 7745.3 7895.4 7953.2 7962.0 7962.0 7962.8 7866.5 7910.6 7928.2 7929.2 7933.8 7799.6 7821.9 7913.5 7921.3 7921.6 36645.8 37019.0 37167.6 37321.1 37333.3 2791.9 3072.0 3400.2 3439.2 3490.9 24688.0 24782.5 25002.2 25011.2 25416.2 3400.4 3402.2 3601.8 3611.8 3625.4 232672.0 233484.8 234206.7 234413.0 234538.0 32564.3 33482.8 33511.5 48201.5 49268.0 32010.0 32050.5 32072.8 32186.5 32261.8 12248.6 12539.5 12553.0 12554.0 12559.1 9400.0 9433.0 9439.1 9454.4 9460.0 8090.5 8098.1 8121.6 8135.4 8194.6 3126.4 3151.7 3164.5 3186.7 3222.6 910.4 915.2 923.8 940.2 1025.9 26154.0 27406.9 27585.4 27805.0 27868.9 825.9 915.9 963.0 966.5 997.0 13129.6 13819.9 14005.3 14032.5 14115.4 342564.0 343476.0 346502.0 349420.0 351532.0 47636.0 48345.5 48454.5 48465.8 48494.3 1185.4 1233.1 1261.2 1263.6 1328.5 25375.7 26816.3 26830.9 27126.0 27428.2 38487.4 38927.4 38934.4 38977.8 39098.6 233988.0 239797.0 240277.0 240416.0 241138.0 22181.0 22921.4 23054.0 23068.7 24524.3 35512.1 35784.8 36275.5 36514.8 36753.8 33990.2 35971.5 36183.8 36791.0 36824.3 30800.0 31314.4 31499.8 31737.0 31747.4 31091.8 31248.4 31633.5 31979.8 32202.0 28241.0 28717.9 28883.4 30701.4 31102.5 22727.0 23210.9 23234.0 23429.0 23546.8 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#2] jquery.html Cycles:180 Average:24726.16 Median:25905.96 stddev:68044.29 (262.7%) stddev-sans-first:68210.61 06:22:08 INFO - PROCESS | 3106 | Values: 374.6 376.7 380.5 381.0 389.7 15323.2 16630.5 17670.7 17693.9 17706.1 15744.6 16163.4 16310.4 16730.4 16730.6 5055.9 5197.7 5224.0 5225.2 5229.5 3633.5 5637.3 5918.8 5933.7 5943.8 5858.0 5886.7 5886.8 5912.1 5913.8 5843.1 6015.8 6034.3 6045.7 6054.4 3278.2 3450.8 3459.0 3462.2 4927.6 19924.7 20428.7 20704.7 20723.2 20756.9 1960.7 2030.4 2061.0 2301.9 2318.5 8835.9 9137.6 9405.3 9488.0 13118.8 1754.3 1790.4 1854.2 1855.5 1861.7 69178.3 70359.0 70589.0 70878.3 71432.0 10023.2 10101.5 10119.6 10134.9 10365.7 14136.9 14212.0 14298.6 14300.1 14300.5 6608.4 6704.0 6738.3 6801.1 6838.8 5860.4 6013.4 6030.0 6042.9 6054.1 4260.6 4306.4 4323.7 4421.2 4429.2 1753.3 1814.9 1834.2 1839.4 1879.5 811.0 858.9 861.1 893.2 928.8 15102.0 16219.9 16582.7 16600.8 16781.9 855.3 860.6 860.9 880.4 887.4 9060.9 9190.6 9249.9 9298.7 9444.9 405366.0 411343.0 411993.0 415261.0 419919.0 75915.0 77685.0 78079.6 78311.0 78595.0 887.7 887.7 896.0 898.9 904.4 14209.6 14256.9 14470.6 14607.1 14917.2 33053.8 33417.2 33872.3 34005.5 34198.3 47382.8 48858.0 48927.5 48967.5 48995.8 7600.7 7615.1 7643.2 7750.2 7824.9 11164.7 11437.4 11445.7 11448.9 11670.7 8426.1 9205.0 9554.4 9557.6 9936.9 9353.3 9707.5 10077.4 10144.8 10145.7 9038.0 10075.4 10446.2 10537.8 10820.8 7572.1 7629.2 7739.0 7817.5 8137.8 9744.3 9886.6 10164.3 10460.4 10686.2 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#3] mootools.html Cycles:180 Average:5097.83 Median:5026.81 stddev:2902.05 (57.7%) stddev-sans-first:2894.52 06:22:08 INFO - PROCESS | 3106 | Values: 1085.1 1134.4 1144.0 1290.3 1677.6 7529.9 7780.2 7781.5 7840.2 7846.3 7637.4 7774.1 7782.0 7794.4 7795.0 1968.4 2014.2 2017.3 2250.1 2271.4 2260.0 2318.3 2321.1 2321.4 2323.1 2190.6 2191.1 2197.1 2199.1 2257.4 1950.6 2194.0 2253.0 2260.9 2261.7 2284.0 2300.3 2301.1 2303.4 2304.0 7580.2 7644.8 7649.3 7657.3 7666.5 4590.6 4727.8 4732.7 4732.8 4733.0 2772.1 2921.7 2928.3 2945.7 2947.1 871.3 875.4 882.4 889.4 911.5 10661.9 10711.6 10716.8 10758.6 10765.9 4370.6 4483.1 4496.5 4515.7 4520.1 8319.9 8366.7 8373.1 8393.2 8405.2 4689.6 4715.2 4728.9 4731.5 4735.6 3618.8 3904.0 4411.0 4415.1 4419.5 3317.8 3385.2 3444.8 3489.1 3510.4 1049.5 1085.6 1089.6 1097.4 1103.0 758.9 760.9 770.8 777.9 783.8 5005.7 5047.9 5075.1 5117.4 5124.4 411.7 414.4 423.5 423.5 440.4 3293.3 3430.2 3466.6 3471.1 3485.9 9377.6 9797.2 9932.9 9940.9 9947.7 9652.4 9800.0 9815.4 9829.1 9829.8 7421.9 7424.6 7433.3 7515.5 7531.8 5123.5 5127.5 5143.6 5149.6 5219.4 8939.0 8948.8 9016.2 9113.3 9117.9 8693.2 8946.6 9106.0 9327.7 9340.1 6505.6 6589.1 6591.7 6629.1 6644.7 6964.9 7307.6 7314.6 7326.8 7346.8 6722.1 6749.3 6790.0 6837.5 6880.1 6645.2 6659.7 6680.4 6791.8 6810.0 6227.0 6287.9 6307.1 6319.5 6323.4 4338.7 4374.2 4442.8 4474.0 4476.0 4355.4 4372.4 4526.2 4534.3 4551.5 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#4] prototype.html Cycles:180 Average:4445.69 Median:5087.55 stddev:1301.90 (25.6%) stddev-sans-first:1268.11 06:22:08 INFO - PROCESS | 3106 | Values: 315.3 316.1 319.9 323.9 325.4 5022.8 5071.8 5090.2 5125.9 5132.5 5076.4 5079.4 5085.6 5089.5 5109.2 3751.8 3855.4 3859.2 3968.7 4013.9 3994.9 3995.8 4015.4 4016.3 4032.5 3742.2 3959.0 3968.6 3968.7 3973.8 3838.9 3969.5 3971.5 3973.4 3979.7 3505.2 3523.9 3526.0 3527.4 3538.2 4904.7 4911.0 4915.1 4921.7 4929.1 4253.3 4501.4 4512.4 4523.1 4580.2 5224.9 5279.7 5280.4 5282.8 5287.4 3746.9 3750.8 3752.1 3752.9 3761.4 5345.7 5564.0 5599.9 5600.7 5627.3 3816.6 3825.3 3841.9 3857.8 3868.1 3897.7 3917.0 3917.4 3919.7 3927.5 4197.9 4503.9 4510.1 4510.3 4519.9 5367.5 5384.9 5391.1 5391.6 5424.0 1357.0 1373.4 1378.1 1378.7 1380.3 839.1 894.2 917.5 920.2 947.1 4679.6 4682.3 4683.3 4686.6 4690.5 5477.1 5497.5 5501.6 5505.6 5511.4 4522.3 4648.4 4683.4 4704.6 4755.7 2943.4 2977.5 2985.1 2986.9 2993.9 5230.3 5238.9 5249.9 5262.4 5271.6 5512.9 5695.5 5714.0 5733.8 5739.1 5230.7 5232.6 5244.3 5245.5 5248.4 5445.8 5571.7 5573.2 5602.8 5603.9 5437.9 5478.6 5490.8 5492.8 5498.6 5224.8 5242.8 5242.8 5248.2 5277.6 3788.1 3871.0 3894.3 3898.3 3905.1 5537.2 5543.7 5578.9 5580.4 5592.9 5344.7 5365.3 5365.4 5390.8 5404.7 5091.2 5384.4 5397.9 5419.2 5424.0 5058.7 5313.5 5328.3 5333.8 5346.6 5246.4 5398.4 5467.5 5470.5 5480.3 5276.4 5281.2 5292.0 5294.7 5322.0 06:22:08 INFO - PROCESS | 3106 | 06:22:08 INFO - PROCESS | 3106 | [#5] yui.html Cycles:180 Average:12239.09 Median:512.26 stddev:13980.32 (2729.2%) stddev-sans-first:13992.49 06:22:08 INFO - PROCESS | 3106 | Values: 660.5 686.2 730.9 739.9 767.6 12201.7 12594.7 12612.9 12659.2 12670.7 12498.5 12559.9 12568.0 12582.3 12598.6 621.0 745.9 780.4 781.0 781.4 773.1 778.7 779.3 779.6 779.8 659.6 817.2 818.3 819.5 819.8 673.1 675.9 793.8 816.5 818.0 602.2 602.3 602.6 602.7 602.9 12049.6 12120.3 12150.2 12157.6 12159.1 11519.6 11669.6 12141.5 12302.0 12318.4 9825.0 9867.2 9911.4 9921.4 10052.6 3184.6 3240.9 3267.8 3326.9 3358.6 42155.4 43638.6 43742.6 45098.3 45572.3 9657.2 9689.4 9720.3 9758.7 9918.6 17032.2 17104.1 17260.6 17336.7 17343.4 6913.1 7039.6 7052.1 7073.1 7078.8 3734.7 3750.2 3755.9 3767.2 3811.8 2891.6 2938.2 2941.9 2942.7 2947.1 484.7 503.5 511.8 521.6 523.4 461.2 512.7 572.7 581.7 615.7 6983.4 7537.2 7558.6 7577.8 7767.3 576.3 603.6 611.9 613.3 614.1 3533.3 3603.5 3605.9 3646.3 3663.2 52108.5 52171.7 52338.0 52827.0 52984.2 46107.1 46433.0 46963.8 47105.0 47386.8 37845.2 37894.6 38948.5 39116.8 39442.0 7420.4 7443.3 7495.6 7662.8 7853.1 25970.6 26657.3 26695.5 27677.6 28293.4 33609.3 35811.5 36770.6 36910.4 37569.0 9486.2 9614.0 9750.4 9814.9 10070.2 10473.4 10534.2 10562.5 10973.5 11296.5 9013.0 9433.4 9897.3 9923.0 10231.6 9689.9 10010.7 10054.5 10070.2 10633.7 10009.0 10377.7 10717.6 10724.5 10764.5 8099.2 8146.2 8207.6 8411.5 8467.0 8226.2 8355.3 8537.8 8720.6 8773.8 06:22:08 INFO - PROCESS | 3106 | -------- Summary: end -------- 06:22:08 INFO - PROCESS | 3106 | 06:22:09 INFO - TEST-INFO | 3106: exit 0 06:22:09 INFO - TEST-OK | dromaeo_css | took 1117887ms 06:22:09 INFO - TEST-START | kraken 06:22:09 INFO - operating with platform_type : linux_ 06:22:09 INFO - Initialising browser for kraken test... 06:22:09 INFO - TEST-INFO | started process 3285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZ0bjJ/profile http://localhost:53249/getInfo.html) 06:22:13 INFO - PROCESS | 3285 | __metrics Screen width/height:1600/1200 06:22:13 INFO - PROCESS | 3285 | colorDepth:24 06:22:13 INFO - PROCESS | 3285 | Browser inner width/height: 1024/697 06:22:13 INFO - PROCESS | 3285 | __metrics 06:22:14 ERROR - PROCESS | 3285 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:22:15 INFO - TEST-INFO | 3285: exit 0 06:22:15 INFO - Browser initialized. 06:22:15 INFO - Running cycle 1/1 for kraken test... 06:22:15 INFO - TEST-INFO | started process 3365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZ0bjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:27 INFO - PROCESS | 3365 | RSS: Main: 155389952 06:22:27 INFO - PROCESS | 3365 | 06:22:30 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-beat-detection) 06:22:31 INFO - PROCESS | 3365 | RSS: Main: 210153472 06:22:31 INFO - PROCESS | 3365 | 06:22:33 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-dft) 06:22:34 INFO - PROCESS | 3365 | RSS: Main: 195678208 06:22:34 INFO - PROCESS | 3365 | 06:22:37 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-fft) 06:22:38 INFO - PROCESS | 3365 | RSS: Main: 266788864 06:22:38 INFO - PROCESS | 3365 | 06:22:40 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-oscillator) 06:22:41 INFO - PROCESS | 3365 | RSS: Main: 174546944 06:22:41 INFO - PROCESS | 3365 | 06:22:43 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:22:43 INFO - PROCESS | 3365 | RSS: Main: 178823168 06:22:43 INFO - PROCESS | 3365 | 06:22:47 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-darkroom) 06:22:47 INFO - PROCESS | 3365 | RSS: Main: 214790144 06:22:47 INFO - PROCESS | 3365 | 06:22:51 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:51 INFO - PROCESS | 3365 | RSS: Main: 215719936 06:22:51 INFO - PROCESS | 3365 | 06:22:54 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53249/tests/kraken/driver.html?testName=json-parse-financial) 06:22:55 INFO - PROCESS | 3365 | RSS: Main: 215576576 06:22:55 INFO - PROCESS | 3365 | 06:22:56 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:57 INFO - PROCESS | 3365 | RSS: Main: 201478144 06:22:57 INFO - PROCESS | 3365 | 06:22:59 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:59 INFO - PROCESS | 3365 | RSS: Main: 204402688 06:22:59 INFO - PROCESS | 3365 | 06:23:01 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:23:02 INFO - PROCESS | 3365 | RSS: Main: 219697152 06:23:02 INFO - PROCESS | 3365 | 06:23:05 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:06 INFO - PROCESS | 3365 | RSS: Main: 225914880 06:23:06 INFO - PROCESS | 3365 | 06:23:09 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:09 INFO - PROCESS | 3365 | RSS: Main: 218877952 06:23:09 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53249/tests/kraken/driver.html?testName=ai-astar) 06:23:11 INFO - PROCESS | 3365 | RSS: Main: 282243072 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | __start_tp_report 06:23:11 INFO - PROCESS | 3365 | _x_x_mozilla_page_load 06:23:11 INFO - PROCESS | 3365 | _x_x_mozilla_page_load_details 06:23:11 INFO - PROCESS | 3365 | |i|pagename|runs| 06:23:11 INFO - PROCESS | 3365 | |0;ai-astar;111;113;110;112;114;115;103;113;113;114 06:23:11 INFO - PROCESS | 3365 | |1;audio-beat-detection;164;136;158;176;139;157;154;140;192;138 06:23:11 INFO - PROCESS | 3365 | |2;audio-dft;162;161;161;162;163;161;161;161;160;161 06:23:11 INFO - PROCESS | 3365 | |3;audio-fft;75;74;97;103;73;76;73;121;100;77 06:23:11 INFO - PROCESS | 3365 | |4;audio-oscillator;95;95;140;94;93;94;140;93;93;148 06:23:11 INFO - PROCESS | 3365 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 06:23:11 INFO - PROCESS | 3365 | |6;imaging-darkroom;145;145;146;145;145;146;146;145;145;145 06:23:11 INFO - PROCESS | 3365 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;94 06:23:11 INFO - PROCESS | 3365 | |8;json-parse-financial;64;66;65;65;64;65;65;78;65;64 06:23:11 INFO - PROCESS | 3365 | |9;json-stringify-tinderbox;65;64;64;64;66;65;65;64;64;67 06:23:11 INFO - PROCESS | 3365 | |10;stanford-crypto-aes;78;78;77;78;81;80;79;80;82;81 06:23:11 INFO - PROCESS | 3365 | |11;stanford-crypto-ccm;135;140;131;131;131;131;131;138;164;134 06:23:11 INFO - PROCESS | 3365 | |12;stanford-crypto-pbkdf2;178;176;174;175;175;183;176;177;185;176 06:23:11 INFO - PROCESS | 3365 | |13;stanford-crypto-sha256-iterative;73;73;72;73;72;72;72;74;73;72 06:23:11 INFO - PROCESS | 3365 | __end_tp_report 06:23:11 INFO - PROCESS | 3365 | __start_cc_report 06:23:11 INFO - PROCESS | 3365 | _x_x_mozilla_cycle_collect,1888 06:23:11 INFO - PROCESS | 3365 | __end_cc_report 06:23:11 INFO - PROCESS | 3365 | __startTimestamp1461331391704__endTimestamp 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | ------- Summary: start ------- 06:23:11 INFO - PROCESS | 3365 | Number of tests: 14 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.43 (3.0%) stddev-sans-first:3.62 06:23:11 INFO - PROCESS | 3365 | Values: 111.0 113.0 110.0 112.0 114.0 115.0 103.0 113.0 113.0 114.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:157.50 stddev:18.36 (11.7%) stddev-sans-first:19.21 06:23:11 INFO - PROCESS | 3365 | Values: 164.0 136.0 158.0 176.0 139.0 157.0 154.0 140.0 192.0 138.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 06:23:11 INFO - PROCESS | 3365 | Values: 162.0 161.0 161.0 162.0 163.0 161.0 161.0 161.0 160.0 161.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#3] audio-fft Cycles:10 Average:86.90 Median:74.50 stddev:17.02 (22.8%) stddev-sans-first:17.50 06:23:11 INFO - PROCESS | 3365 | Values: 75.0 74.0 97.0 103.0 73.0 76.0 73.0 121.0 100.0 77.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.50 stddev:23.69 (25.3%) stddev-sans-first:24.62 06:23:11 INFO - PROCESS | 3365 | Values: 95.0 95.0 140.0 94.0 93.0 94.0 140.0 93.0 93.0 148.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:23:11 INFO - PROCESS | 3365 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:23:11 INFO - PROCESS | 3365 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:23:11 INFO - PROCESS | 3365 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:4.23 (6.5%) stddev-sans-first:4.42 06:23:11 INFO - PROCESS | 3365 | Values: 64.0 66.0 65.0 65.0 64.0 65.0 65.0 78.0 65.0 64.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 06:23:11 INFO - PROCESS | 3365 | Values: 65.0 64.0 64.0 64.0 66.0 65.0 65.0 64.0 64.0 67.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.67 06:23:11 INFO - PROCESS | 3365 | Values: 78.0 78.0 77.0 78.0 81.0 80.0 79.0 80.0 82.0 81.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.50 stddev:10.17 (7.6%) stddev-sans-first:10.77 06:23:11 INFO - PROCESS | 3365 | Values: 135.0 140.0 131.0 131.0 131.0 131.0 131.0 138.0 164.0 134.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:176.50 stddev:3.63 (2.1%) stddev-sans-first:3.84 06:23:11 INFO - PROCESS | 3365 | Values: 178.0 176.0 174.0 175.0 175.0 183.0 176.0 177.0 185.0 176.0 06:23:11 INFO - PROCESS | 3365 | 06:23:11 INFO - PROCESS | 3365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 06:23:11 INFO - PROCESS | 3365 | Values: 73.0 73.0 72.0 73.0 72.0 72.0 72.0 74.0 73.0 72.0 06:23:11 INFO - PROCESS | 3365 | -------- Summary: end -------- 06:23:11 INFO - PROCESS | 3365 | 06:23:12 INFO - TEST-INFO | 3365: exit 0 06:23:12 INFO - TEST-OK | kraken | took 63176ms 06:23:12 INFO - SUITE-END | took 1181s 06:23:12 INFO - Completed test suite (00:19:41) 06:23:12 INFO - javascript benchmark 06:23:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.259780962426, 2679.423923856372, 2684.1544913352304, 2703.716109808469, 2719.225020869052, 4505.684602077856, 4609.216433206355, 4658.440987081551, 4681.6020638245745, 4686.90626187476, 4684.227102528079, 4725.40932383452, 4728.4798672146035, 4772.928406073912, 4775.973165769359, 4243.766592837401, 4259.190753756776, 4267.637250833667, 4332.7833608319615, 4406.889827754316, 4309.698321117523, 4356.1723272578265, 4371.169477799224, 4380.649548036149, 4423.491298500681, 4172.18642364739, 4253.3619957006695, 4267.701260911737, 4285.678574106923, 4361.498427680794, 4329.1558146161515, 4340.934885976713, 4343.2399330117105, 4345.891352716208, 4394.758288294142, 4316.870493885157, 4322.481302243751, 4325.913481730379, 4364.759938203398, 4369.912601747979, 4459.063596644709, 4527.253003254459, 4555.726656400627, 4637.489876113625, 4657.767111644438, 5015.197568389077, 5015.749212539395, 5018.096742586333, 5020.447750747415, 5056.570191533724, 5029.7736601853, 5036.84889453317, 5044.9747751261375, 5048.368953880765, 5070.163423035195, 4597.080583883237, 4670.3461515387535, 4758.0246049559755, 4759.000609871897, 4760.33355330254, 5121.119648519434, 5137.717425541631, 5144.408393034849, 5149.356330458692, 5203.557697595671, 4934.210526315772, 4935.7532123393685, 4937.382827146606, 4939.333190019302, 4992.550670439605, 4784.114938736276, 4985.451600323961, 5028.396592408862, 5069.44236134025, 5091.541761241432, 4984.37695288089, 5018.121828679967, 5018.974905125451, 5022.196448568285, 5036.043151801146, 4991.151504244287, 4997.750112494361, 5000.2749601307605, 5007.023630392038, 5059.797608095709, 4151.91696166075, 4202.663786897041, 4217.198732240864, 4218.8523401681405, 4263.0, 3725.3294407006456, 3742.700583953277, 3744.700423966076, 3767.171222331083, 3783.659470647655, 4359.346098085312, 4363.192809330284, 4368.213721530092, 4396.384506169139, 4421.690481666253, 4940.7035577865445, 4969.776360063805, 5053.898922021613, 5068.366454193226, 5078.619103567247, 4345.521992580813, 4362.236608593484, 4380.123975204971, 4408.889777755582, 4409.338599210144, 4533.841315554006, 4537.6143027842345, 4540.6821522493765, 4540.6821522493765, 4586.908261834745, 4640.327152562927, 4709.270063140219, 4724.9763751180335, 4762.738049407316, 4798.1123492154065, 4898.167311557115, 4914.729689867092, 4919.655624106278, 4924.089043526959, 4987.12725273083, 4630.536946305342, 4632.953670463252, 4633.467151277646, 4666.043461090536, 4703.647226458098, 4799.712017278975, 4854.417469903634, 4868.0, 4956.405231372259, 4962.181240095344, 5016.698998060128, 5024.145895197752, 5043.52086551777, 5053.620978426559, 5099.949000509948, 4899.779509921991, 4903.509649035068, 4910.803567857246, 4913.238448040559, 4957.82647607332, 4776.546228108463, 4843.4430040545785, 4910.975445122752, 4940.011997600566, 4971.950280497149, 4828.589569886599, 4860.3195552621955, 4874.0, 4923.803047878045, 4928.778204980713, 4826.806927722992, 4956.281339205867, 4967.82612608557, 4987.202047672355, 5038.748062596929, 4774.522547745337, 4810.086083644096, 4818.349522814516, 4853.417589889236, 4866.853994380174], "value": 4611.426139591166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8160588611644, 594.1355327997761, 606.251279669608, 610.6610830988805, 616.014376996805, 26196.73803261969, 26822.0, 34284.828575857086, 35368.46947295793, 35493.46759798605, 36692.44961325582, 37438.43842342367, 37493.25013499728, 37526.0, 37564.81217593915, 7540.0, 7782.9610851945945, 7784.688612455495, 7785.182555831641, 7796.142424333347, 7610.277023682769, 7718.382529397635, 7736.690532378698, 7742.032245969254, 7745.3029227369525, 7895.447318687694, 7953.244441778022, 7962.044554653449, 7962.044554653449, 7962.800929976768, 7866.488678235896, 7910.564918929428, 7928.167542408022, 7929.207079292025, 7933.801654958615, 7799.5710235937, 7821.882671759929, 7913.525188488651, 7921.287084162395, 7921.603919803987, 36645.816770916244, 37019.0, 37167.628323716686, 37321.066973325615, 37333.25333493315, 2791.9441611167867, 3072.0476652237653, 3400.2009527760956, 3439.174598096464, 3490.930181396358, 24688.0, 24782.504349912902, 25002.249932502054, 25011.249662510152, 25416.237512874643, 3400.4389275769468, 3402.1834759657504, 3601.7838929664304, 3611.7652352596997, 3625.401808701561, 232672.0, 233484.83257583773, 234206.65793342018, 234413.0, 234538.0, 32564.348713025607, 33482.8325858374, 33511.497327540106, 48201.517984820406, 49268.0, 32010.0, 32050.519242211387, 32072.839635801673, 32186.517202241987, 32261.838690806395, 12248.632541023784, 12539.498420063277, 12553.0, 12554.0, 12559.058070644738, 9400.0, 9433.0, 9439.103285187895, 9454.385464944757, 9460.0, 8090.514569125754, 8098.068722097034, 8121.593920303962, 8135.389845761473, 8194.590270486571, 3126.4059828632944, 3151.73210277129, 3164.5095010273444, 3186.745060395163, 3222.5971753530807, 910.4400793512075, 915.2449229385651, 923.7644400677784, 940.2330185957131, 1025.9487025648689, 26154.0, 27406.862965685043, 27585.448291034467, 27805.0, 27868.860655696593, 825.9421840471109, 915.8900931888217, 963.0417734354362, 966.4732720667254, 996.9960379636982, 13129.606111816469, 13819.930900345435, 14005.299735013412, 14032.508862189774, 14115.364808583638, 342564.0, 343476.0, 346502.0, 349420.0, 351532.0, 47636.0, 48345.516544834805, 48454.51545484571, 48465.75767121212, 48494.27258591124, 1185.3523602192959, 1233.0505510756846, 1261.1550261324935, 1263.551439239057, 1328.5350127455313, 25375.746242537338, 26816.32959176036, 26830.865845670647, 27126.0, 27428.177154685392, 38487.422688659135, 38927.41608875926, 38934.41598376083, 38977.80511097427, 39098.609013909496, 233988.0, 239797.0, 240277.0, 240416.0, 241138.0, 22181.0, 22921.426964326027, 23054.0, 23068.653970190797, 24524.264272071865, 35512.112197195274, 35784.821075894455, 36275.45586816147, 36514.8174259127, 36753.81623091974, 33990.15024624404, 35971.46042809307, 36183.819080904424, 36791.0, 36824.26351473009, 30800.0, 31314.373712526078, 31499.84250078735, 31737.0, 31747.365052698355, 31091.84454077715, 31248.375032499676, 31633.5254971171, 31979.84010079935, 32202.03393898093, 28241.0, 28717.856410717814, 28883.422331552832, 30701.385972279983, 31102.533461997635, 22727.0, 23210.883945580164, 23234.0, 23429.0, 23546.764532354457], "value": 15502.096043952859, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.59356598091085, 376.6572419098621, 380.54144755569536, 380.969522438205, 389.72913824891714, 15323.233838308082, 16630.501084967455, 17670.734938975893, 17693.91153044236, 17706.114694265285, 15744.606384840385, 16163.353465861352, 16310.429134980279, 16730.41443549476, 16730.58173545662, 5055.949440505585, 5197.688138711671, 5224.033553792541, 5225.216217567377, 5229.529342359187, 3633.5276414066266, 5637.295338082739, 5918.792842250522, 5933.694587190833, 5943.821685349447, 5858.0, 5886.676232807194, 5886.793962211324, 5912.113183022538, 5913.763449462038, 5843.123531470271, 6015.849603759897, 6034.30605480371, 6045.667488288121, 6054.394560543955, 3278.1804548862783, 3450.8447119879415, 3459.0487615905577, 3462.221000274943, 4927.556519913225, 19924.70112948307, 20428.693569596468, 20704.689429658567, 20723.171073157057, 20756.896215518977, 1960.6764883794158, 2030.4111807575784, 2060.9690854637192, 2301.9424514387106, 2318.455163036702, 8835.867461988075, 9137.588808503633, 9405.294602904809, 9488.0, 13118.803217951738, 1754.3158168314367, 1790.3733693207403, 1854.2119599170298, 1855.4804654696707, 1861.720741888714, 69178.30821691769, 70359.0, 70589.0, 70878.29121708768, 71432.0, 10023.2482563808, 10101.494925253708, 10119.59521619127, 10134.898651013544, 10365.689029329133, 14136.85863141376, 14212.0, 14298.57104286873, 14300.141991480545, 14300.499482518062, 6608.438282745924, 6704.0, 6738.292479289702, 6801.081853949752, 6838.760643377458, 5860.38465961068, 6013.398660133952, 6029.969850150809, 6042.879142417127, 6054.122152287981, 4260.6378457830815, 4306.397104405386, 4323.718958267703, 4421.159979603865, 4429.15845989261, 1753.298680527799, 1814.8638852086146, 1834.1562881074856, 1839.3654189304668, 1879.473747350744, 810.9635066422026, 858.9398742088118, 861.0571424290392, 893.2452077994085, 928.7538802217417, 15102.0, 16219.918900405422, 16582.66834663324, 16600.83399166017, 16781.91609041947, 855.3242938078972, 860.5654144656908, 860.9483430994161, 880.366136381804, 887.4231749362966, 9060.864087038699, 9190.58642361082, 9249.861252081224, 9298.72103836886, 9444.8583271251, 405366.0, 411343.0, 411993.0, 415261.0, 419919.0, 75915.0, 77685.0, 78079.60960195276, 78311.0, 78595.0, 887.6893087419352, 887.745952922855, 896.0412358776047, 898.883145191121, 904.3579058868277, 14209.644758881112, 14256.857431425553, 14470.638234044232, 14607.050541714754, 14917.179555124572, 33053.834730826195, 33417.16457088592, 33872.3225535483, 34005.48991765076, 34198.290085496126, 47382.76308618435, 48858.0, 48927.510724892294, 48967.51032489629, 48995.755021224664, 7600.733974311093, 7615.1242607098675, 7643.197464266172, 7750.186230445947, 7824.921750782647, 11164.720881978015, 11437.428128593703, 11445.713857153638, 11448.885511144781, 11670.70823229426, 8426.073131955603, 9204.98745138021, 9554.378965367228, 9557.569909354235, 9936.900630993598, 9353.251739860658, 9707.466089365153, 10077.445740484343, 10144.79710405773, 10145.746356340855, 9037.954810225907, 10075.395476271447, 10446.216533759847, 10537.841932370868, 10820.783584328427, 7572.129205141259, 7629.160792312952, 7739.032620922385, 7817.5309481431295, 8137.8372432552205, 9744.317897747089, 9886.555105020147, 10164.33931794431, 10460.372377657364, 10686.198535109743], "value": 8105.216246490927, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1085.1427372375824, 1134.3987686526143, 1143.9599614013512, 1290.3032362524236, 1677.6225349296403, 7529.8870516942225, 7780.183080776507, 7781.494202876809, 7840.215978402157, 7846.254605812446, 7637.427192960522, 7774.0671119465605, 7781.961090194541, 7794.415418843581, 7795.0, 1968.3602829080605, 2014.1540552967715, 2017.2737814386883, 2250.111206073604, 2271.3526644906124, 2259.9774002260015, 2318.258157389636, 2321.071571371448, 2321.442853715105, 2323.117215458132, 2190.5618876224817, 2191.1235505797727, 2197.099189332374, 2199.098369668436, 2257.3792207143083, 1950.5611237471596, 2194.0455901682817, 2253.0, 2260.864348139117, 2261.728592568902, 2284.0, 2300.3214051854743, 2301.079568172744, 2303.4011157099108, 2303.953920921589, 7580.241975802431, 7644.770656880302, 7649.273319034683, 7657.349125324354, 7666.501677391007, 4590.60979816716, 4727.810887564493, 4732.739699316537, 4732.763361831895, 4733.0, 2772.1129238643643, 2921.6786153523094, 2928.253295409657, 2945.7348838604416, 2947.1158652404406, 871.324723339417, 875.4353442029856, 882.3779235638859, 889.3907673243849, 911.5396724654007, 10661.893381066167, 10711.625093121782, 10716.785664286748, 10758.623448179276, 10765.892341076646, 4370.628496577763, 4483.058557702853, 4496.505384407778, 4515.706479078849, 4520.095980803852, 8319.916800832036, 8366.748997530083, 8373.07896131425, 8393.202645748644, 8405.243528082501, 4689.62483001359, 4715.221988371949, 4728.929066064012, 4731.526847315241, 4735.550122738335, 3618.782873027627, 3903.9609603903596, 4411.0, 4415.139047885696, 4419.491758447755, 3317.8175200364212, 3385.2213990781765, 3444.7588668793446, 3489.1102768793794, 3510.350585141757, 1049.454283772434, 1085.647164671485, 1089.591403223791, 1097.434821067151, 1102.972425689348, 758.8558173947043, 760.8517973637644, 770.7957391291312, 777.9105402878741, 783.7570353190529, 5005.724685142352, 5047.899042019139, 5075.111855425286, 5117.437081920985, 5124.385073791169, 411.69903106184313, 414.40325930659753, 423.45585922090584, 423.4833503126181, 440.44064038670706, 3293.275479394529, 3430.2453460238708, 3466.6360032196762, 3471.149568355769, 3485.9302813944087, 9377.578008989612, 9797.216222702167, 9932.900670993342, 9940.906500284962, 9947.701568952943, 9652.372595781393, 9799.951000244953, 9815.36200146988, 9829.066238707312, 9829.754256143653, 7421.888671670037, 7424.591647459441, 7433.331000210007, 7515.473916825769, 7531.774046778605, 5123.462036486116, 5127.512886275797, 5143.61422893277, 5149.639525233198, 5219.399769026611, 8938.955305223692, 8948.821023579621, 9016.18854303116, 9113.3165012623, 9117.908820911705, 8693.217610415093, 8946.552672366226, 9105.954470227607, 9327.673531426368, 9340.065993400605, 6505.577137486048, 6589.110470086477, 6591.670416479253, 6629.07192992991, 6644.734210631714, 6964.877204499902, 7307.561546307238, 7314.634268286671, 7326.81682957909, 7346.77959661211, 6722.05891175226, 6749.291324410866, 6789.966050169717, 6837.453003759787, 6880.105586273752, 6645.202575690754, 6659.733610655713, 6680.365365290289, 6791.762288319885, 6809.965950170217, 6227.0, 6287.937120628735, 6307.085472606354, 6319.52603554726, 6323.430891219812, 4338.717983331074, 4374.21264172452, 4442.844500442469, 4474.015716542355, 4476.037651904856, 4355.368471571668, 4372.431583894074, 4526.185286648435, 4534.342520334599, 4551.47658019332], "value": 4010.476516252698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2717223214374, 316.09438957387084, 319.94880819068953, 323.89959112675075, 325.4045097471627, 5022.773975171117, 5071.797128114876, 5090.236464530322, 5125.948740512594, 5132.512411320928, 5076.416212135606, 5079.415867175276, 5085.567726743231, 5089.541941225289, 5109.233614957759, 3751.831167597458, 3855.363864962278, 3859.1895701902636, 3968.702347323948, 4013.9197216055663, 3994.8601798937043, 3995.760254384746, 4015.4339807475108, 4016.2569924563904, 4032.5362583302854, 3742.195427982983, 3959.0, 3968.618828702784, 3968.72218944674, 3973.7615743055508, 3838.888611263808, 3969.4641223434755, 3971.463852379921, 3973.364261718126, 3979.7413168143976, 3505.1587618971516, 3523.894283171509, 3525.964740352589, 3527.417976033951, 3538.239278555123, 4904.705717656952, 4911.0, 4915.066137433876, 4921.704697718113, 4929.112759703252, 4253.2769429197115, 4501.369808226851, 4512.390827238313, 4523.117991991563, 4580.152671755703, 5224.869378265574, 5279.736013199325, 5280.4422695304975, 5282.7622756976025, 5287.444818294062, 3746.925061498782, 3750.79370634615, 3752.080740218664, 3752.9437058444146, 3761.360568703327, 5345.679259244458, 5564.0, 5599.8880022399735, 5600.691961942091, 5627.2684551008515, 3816.637419445148, 3825.2923209206388, 3841.9423708644395, 3857.8263978121054, 3868.0716628009077, 3897.6686981606313, 3916.96083039166, 3917.353636649978, 3919.6864250859862, 3927.489426374553, 4197.853075142355, 4503.88740281489, 4510.14307281622, 4510.300903359985, 4519.887002824956, 5367.5169234769055, 5384.865378365572, 5391.137418013099, 5391.649542779785, 5423.972880135574, 1356.959291221265, 1373.3545233740126, 1378.0904602961998, 1378.696686728918, 1380.289151087191, 839.0644431458879, 894.2488309819653, 917.454114801692, 920.1718453392001, 947.0860619502214, 4679.602233810097, 4682.274247491644, 4683.297505374221, 4686.601638860667, 4690.460597031385, 5477.123660214346, 5497.45025497447, 5501.587380946445, 5505.559555235572, 5511.366192887789, 4522.321651752263, 4648.372469716613, 4683.391159149289, 4704.576588107018, 4755.714657120584, 2943.351723035107, 2977.464056469813, 2985.104468659437, 2986.850657467118, 2993.8802447902276, 5230.320058392384, 5238.895222095537, 5249.897521520524, 5262.421133675292, 5271.551918086929, 5512.91730624041, 5695.45893140151, 5714.0, 5733.827985160452, 5739.139129130664, 5230.7384630769075, 5232.607554433433, 5244.292020577173, 5245.501677340647, 5248.448912864171, 5445.809396671098, 5571.721413929368, 5573.191887176417, 5602.831915042555, 5603.8792241552665, 5437.918431223614, 5478.616496845342, 5490.752916118704, 5492.80775172867, 5498.642588231752, 5224.817131400535, 5242.76407561653, 5242.842714718565, 5248.160294352885, 5277.630565860353, 3788.1389249687854, 3870.96129038706, 3894.3184942635494, 3898.317794386028, 3905.1018265798457, 5537.197106419627, 5543.722813859372, 5578.916316255179, 5580.414056524007, 5592.888142237214, 5344.732763361894, 5365.275687782099, 5365.436629153883, 5390.838274851761, 5404.702741349263, 5091.1854103343285, 5384.380796208487, 5397.9190312144565, 5419.182025346877, 5423.972880135574, 5058.696478211172, 5313.54834839043, 5328.280682107866, 5333.839984800462, 5346.572274218131, 5246.422893481637, 5398.40617532079, 5467.507924286833, 5470.53500452466, 5480.287562616834, 5276.445973172762, 5281.15501519755, 5292.04743146222, 5294.729264976455, 5322.0], "value": 4033.784178653701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.4518249852623, 686.1937223762078, 730.8757511223091, 739.8964145019696, 767.6315368623061, 12201.694957626063, 12594.748105037894, 12612.936935315334, 12659.177153485018, 12670.683232919182, 12498.500059997588, 12559.874401255986, 12568.0, 12582.307973061477, 12598.622041338751, 620.9968950155243, 745.8732015557341, 780.3640033372811, 780.9843803123935, 781.413939545341, 773.1225059557414, 778.6807408962327, 779.2713812585223, 779.6218833865571, 779.777763337449, 659.5712786688642, 817.2154731457807, 818.3494122172887, 819.4509678515409, 819.848328059308, 673.1316601583951, 675.9290274521178, 793.7658390774735, 816.542736067798, 817.9795505112361, 602.1509671363357, 602.2682440834408, 602.5751844949344, 602.6564858030924, 602.8523011862078, 12049.578264760692, 12120.272783632921, 12150.210236334698, 12157.574484892986, 12159.148859579833, 11519.596814111466, 11669.591564295293, 12141.514339426412, 12302.0, 12318.384080796013, 9824.950875245579, 9867.16129129025, 9911.355761875455, 9921.40471571708, 10052.64815731446, 3184.601924759405, 3240.902772916816, 3267.787593806395, 3326.900192994214, 3358.580177477815, 42155.367669484986, 43638.56361436409, 43742.56257437385, 45098.32352514715, 45572.3164152538, 9657.22742180638, 9689.370190937567, 9720.319577629498, 9758.658446954465, 9918.553665085088, 17032.2335494903, 17104.05927673965, 17260.568485787957, 17336.65326693459, 17343.392981245597, 6913.1358580177475, 7039.648017599099, 7052.118485189351, 7073.115860517435, 7078.787636370917, 3734.7012239020814, 3750.1937083527173, 3755.9061023474633, 3767.246550689873, 3811.8094095295123, 2891.640928763478, 2938.177310353062, 2941.8529073546665, 2942.735153836165, 2947.0864032149675, 484.69222044001606, 503.509078648315, 511.836212412032, 521.6061873285645, 523.374567391963, 461.2366533387249, 512.6744517231584, 572.7479908840097, 581.7236812514022, 615.6829232945037, 6983.406410455066, 7537.200241888237, 7558.622068896533, 7577.810554736066, 7767.262110099531, 576.3429690153229, 603.6016229288737, 611.9479844213203, 613.349849159892, 614.1371373220633, 3533.293341331744, 3603.4955106285142, 3605.8557657693923, 3646.2889736501656, 3663.157473781045, 52108.47891521036, 52171.73914130481, 52338.0, 52827.0, 52984.20523692148, 46107.077858442644, 46433.0, 46963.76518117456, 47105.0, 47386.763066184445, 37845.243095138496, 37894.62105378966, 38948.46834955719, 39116.804415977735, 39442.0, 7420.443466739908, 7443.292887175709, 7495.587742674205, 7662.846743064996, 7853.136155023057, 25970.610440843026, 26657.333566660214, 26695.466090678467, 27677.584836227874, 28293.43413131767, 33609.327813444084, 35811.462828058124, 36770.63229367672, 36910.446343304335, 37569.0, 9486.241100711788, 9613.951930240304, 9750.366226195274, 9814.852777208205, 10070.244731645009, 10473.423961681876, 10534.209934255116, 10562.524686388977, 10973.451327433757, 11296.49165787558, 9012.967688136412, 9433.386829856037, 9897.25770567196, 9923.0, 10231.590736370461, 9689.854652180364, 10010.749731256778, 10054.54754536033, 10070.19438444908, 10633.734156646145, 10009.0, 10377.740556486147, 10717.624883129365, 10724.463776810971, 10764.461776910966, 8099.190080991853, 8146.2261085196815, 8207.58962051907, 8411.495310281403, 8467.0, 8226.177382261725, 8355.289800367036, 8537.786555336166, 8720.563971801512, 8773.824523509622], "value": 5693.428956565514, "unit": "score"}], "name": "dromaeo_css", "value": 6136.009538490706, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 110.0, 112.0, 114.0, 115.0, 103.0, 113.0, 113.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 136.0, 158.0, 176.0, 139.0, 157.0, 154.0, 140.0, 192.0, 138.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 97.0, 103.0, 73.0, 76.0, 73.0, 121.0, 100.0, 77.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 140.0, 94.0, 93.0, 94.0, 140.0, 93.0, 93.0, 148.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 78.0, 65.0, 64.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 67.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 78.0, 81.0, 80.0, 79.0, 80.0, 82.0, 81.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 131.0, 131.0, 131.0, 131.0, 131.0, 138.0, 164.0, 134.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 174.0, 175.0, 175.0, 183.0, 176.0, 177.0, 185.0, 176.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 72.0, 72.0, 72.0, 74.0, 73.0, 72.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1577.9999999999998, "alertThreshold": 2.0}]} 06:23:12 INFO - Return code: 0 06:23:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:23:13 ERROR - # TBPL SUCCESS # 06:23:13 INFO - Running post-action listener: _resource_record_post_action 06:23:13 INFO - Running post-run listener: _resource_record_post_run 06:23:14 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 535334912; Read time: 0; Write time: 632932 06:23:14 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234545152; Read time: 0; Write time: 390588 06:23:14 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282857472; Read time: 0; Write time: 224420 06:23:14 INFO - Running post-run listener: _upload_blobber_files 06:23:14 INFO - Blob upload gear active. 06:23:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:14 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 06:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:23:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:23:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:23:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:15 INFO - (blobuploader) - INFO - Done attempting. 06:23:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:23:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:16 INFO - (blobuploader) - INFO - Done attempting. 06:23:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:16 INFO - Return code: 0 06:23:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72bfa56526cfaece8a2fe9a1b9180c4399c8af2bb429c2ca9c3f776fc94774f67d9e5fefbabb02c870fd4634c9fd4f6d0bd99f1e6c8778f4dd39ac667436f5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309de669525352137d4dfef2bf0f12649581382611f9dba1aae94d49a4dda236208b2dbc56e23de5782527320f2d912bc66465400913e469f42b091d9bfea2ea"} 06:23:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:16 INFO - Contents: 06:23:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72bfa56526cfaece8a2fe9a1b9180c4399c8af2bb429c2ca9c3f776fc94774f67d9e5fefbabb02c870fd4634c9fd4f6d0bd99f1e6c8778f4dd39ac667436f5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309de669525352137d4dfef2bf0f12649581382611f9dba1aae94d49a4dda236208b2dbc56e23de5782527320f2d912bc66465400913e469f42b091d9bfea2ea"} 06:23:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:16 INFO - Copying logs to upload dir... 06:23:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.245154 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:23:15.392240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:23:15.395470) ========= 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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72bfa56526cfaece8a2fe9a1b9180c4399c8af2bb429c2ca9c3f776fc94774f67d9e5fefbabb02c870fd4634c9fd4f6d0bd99f1e6c8778f4dd39ac667436f5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309de669525352137d4dfef2bf0f12649581382611f9dba1aae94d49a4dda236208b2dbc56e23de5782527320f2d912bc66465400913e469f42b091d9bfea2ea"} build_url:https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/ONsAfcixRJK7MBV634YtbQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72bfa56526cfaece8a2fe9a1b9180c4399c8af2bb429c2ca9c3f776fc94774f67d9e5fefbabb02c870fd4634c9fd4f6d0bd99f1e6c8778f4dd39ac667436f5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309de669525352137d4dfef2bf0f12649581382611f9dba1aae94d49a4dda236208b2dbc56e23de5782527320f2d912bc66465400913e469f42b091d9bfea2ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:23:15.424066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:23:15.424412) ========= 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-1461330136.976483-1746752305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:23:15.507086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:23:15.507504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:23:15.507881) ========= ========= Total master_lag: 0.17 =========