builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1461949472.76 results: success (0) buildid: 20160429091131 builduid: f5b3b70d23a64846b5f00c7562bda851 revision: cc898e5dfa22a5263e34488baccd32c2ca275f30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.760616) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.761586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.762403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.783900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.784234) ========= 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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 10:04:32-- 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% 263K=0.05s 2016-04-29 10:04:32 (263 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.923938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.924301) ========= 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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.974186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:32.974572) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cc898e5dfa22a5263e34488baccd32c2ca275f30 --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 cc898e5dfa22a5263e34488baccd32c2ca275f30 --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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 10:04:33,102 truncating revision to first 12 chars 2016-04-29 10:04:33,102 Setting DEBUG logging. 2016-04-29 10:04:33,102 attempt 1/10 2016-04-29 10:04:33,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cc898e5dfa22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 10:04:33,352 unpacking tar archive at: fx-team-cc898e5dfa22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540332 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:33.529549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:33.529886) ========= script_repo_revision: cc898e5dfa22a5263e34488baccd32c2ca275f30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:33.530328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:33.530597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:04:33.539433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 10:04:33.539708) ========= /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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:33 INFO - MultiFileLogger online at 20160429 10:04:33 in /builds/slave/test 10:04:33 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 10:04:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:33 INFO - {'append_to_log': False, 10:04:33 INFO - 'base_work_dir': '/builds/slave/test', 10:04:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:04:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:33 INFO - 'branch': 'Fx-Team-Non-PGO', 10:04:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:33 INFO - 'config_files': ('talos/linux_config.py',), 10:04:33 INFO - 'default_actions': ('clobber', 10:04:33 INFO - 'read-buildbot-config', 10:04:33 INFO - 'download-and-extract', 10:04:33 INFO - 'populate-webroot', 10:04:33 INFO - 'create-virtualenv', 10:04:33 INFO - 'install', 10:04:33 INFO - 'run-tests'), 10:04:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:33 INFO - 'download_minidump_stackwalk': True, 10:04:33 INFO - 'download_symbols': 'ondemand', 10:04:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:33 INFO - 'installer_path': 'installer.exe', 10:04:33 INFO - 'log_level': 'info', 10:04:33 INFO - 'log_name': 'talos', 10:04:33 INFO - 'log_to_console': True, 10:04:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:33 INFO - 'opt_config_files': (), 10:04:33 INFO - 'pip_index': False, 10:04:33 INFO - 'sps_profile': False, 10:04:33 INFO - 'sps_profile_interval': 0, 10:04:33 INFO - 'suite': 'dromaeojs', 10:04:33 INFO - 'system_bits': '32', 10:04:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:33 INFO - 'title': 'talos-linux64-ix-016', 10:04:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:33 INFO - 'use_talos_json': True, 10:04:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:33 INFO - 'work_dir': 'build'} 10:04:33 INFO - ##### 10:04:33 INFO - ##### Running clobber step. 10:04:33 INFO - ##### 10:04:33 INFO - Running pre-action listener: _resource_record_pre_action 10:04:33 INFO - Running main action method: clobber 10:04:33 INFO - rmtree: /builds/slave/test/build 10:04:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - ##### 10:04:34 INFO - ##### Running read-buildbot-config step. 10:04:34 INFO - ##### 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: read_buildbot_config 10:04:34 INFO - Using buildbot properties: 10:04:34 INFO - { 10:04:34 INFO - "project": "", 10:04:34 INFO - "product": "firefox", 10:04:34 INFO - "script_repo_revision": "production", 10:04:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:04:34 INFO - "repository": "", 10:04:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:04:34 INFO - "buildid": "20160429091131", 10:04:34 INFO - "pgo_build": "False", 10:04:34 INFO - "basedir": "/builds/slave/test", 10:04:34 INFO - "buildnumber": 1618, 10:04:34 INFO - "slavename": "talos-linux64-ix-016", 10:04:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:04:34 INFO - "platform": "ubuntu64_hw", 10:04:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:04:34 INFO - "branch": "fx-team", 10:04:34 INFO - "repo_path": "integration/fx-team", 10:04:34 INFO - "revision": "cc898e5dfa22a5263e34488baccd32c2ca275f30", 10:04:34 INFO - "stage_platform": "linux64", 10:04:34 INFO - "builduid": "f5b3b70d23a64846b5f00c7562bda851", 10:04:34 INFO - "slavebuilddir": "test" 10:04:34 INFO - } 10:04:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - ##### 10:04:34 INFO - ##### Running download-and-extract step. 10:04:34 INFO - ##### 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: download_and_extract 10:04:34 INFO - mkdir: /builds/slave/test/build/tests 10:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:04:34 INFO - https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:04:39 INFO - Downloaded 1361 bytes. 10:04:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:04:39 INFO - Using the following test package requirements: 10:04:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:04:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'jsshell-linux-x86_64.zip'], 10:04:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:04:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:04:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04: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')]} 10:04:39 INFO - https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:44 INFO - Downloaded 22301146 bytes. 10:04:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:45 INFO - Return code: 0 10:04:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:49 INFO - Downloaded 22301146 bytes. 10:04:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:50 INFO - Return code: 0 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:50 INFO - https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:04:51 INFO - Downloaded 10840145 bytes. 10:04:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:04:51 INFO - Return code: 0 10:04:51 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')]} 10:04:51 INFO - https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:04:53 INFO - Downloaded 54851120 bytes. 10:04:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:04:53 INFO - mkdir: /builds/slave/test/properties 10:04:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:53 INFO - Contents: 10:04:53 INFO - build_url:https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:04:54 INFO - Running post-action listener: _resource_record_post_action 10:04:54 INFO - Running post-action listener: set_extra_try_arguments 10:04:54 INFO - ##### 10:04:54 INFO - ##### Running populate-webroot step. 10:04:54 INFO - ##### 10:04:54 INFO - Running pre-action listener: _resource_record_pre_action 10:04:54 INFO - Running main action method: populate_webroot 10:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:54 INFO - '--tppagecycles', 10:04:54 INFO - '7'], 10:04:54 INFO - 'tests': ['tsvgm']}}, 10:04:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['damp', 'tps']}, 10:04:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'tests': ['damp', 'tps']}, 10:04:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['dromaeo_dom']}, 10:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tsvgx', 10:04:54 INFO - 'tsvgr_opacity', 10:04:54 INFO - 'tart', 10:04:54 INFO - 'tscrollx', 10:04:54 INFO - 'cart']}, 10:04:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:54 INFO - 'tsvgr_opacity', 10:04:54 INFO - 'tart', 10:04:54 INFO - 'tscrollx', 10:04:54 INFO - 'cart']}, 10:04:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tp5o']}, 10:04:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'tests': ['tp5o']}, 10:04:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s', 10:04:54 INFO - '--xperf_path', 10:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:54 INFO - 'tests': ['tp5n']}, 10:04:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:54 INFO - 'talos_options': ['--xperf_path', 10:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:54 INFO - 'tests': ['tp5n']}}, 10:04:54 INFO - 'talos.zip': {'path': '', 10:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:54 INFO - Running post-action listener: _resource_record_post_action 10:04:54 INFO - ##### 10:04:54 INFO - ##### Running create-virtualenv step. 10:04:54 INFO - ##### 10:04:54 INFO - Running pre-action listener: _resource_record_pre_action 10:04:54 INFO - Running main action method: create_virtualenv 10:04:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:54 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 10:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:54 INFO - Using real prefix '/usr' 10:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:56 INFO - Installing pip.................done. 10:04:56 INFO - Return code: 0 10:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:56 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')]} 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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')]} 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:04:56 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 10:04:56 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 10:04:56 INFO - Using env: {'DISPLAY': ':0', 10:04:56 INFO - 'HOME': '/home/cltbld', 10:04:56 INFO - 'LANG': 'en_US.UTF-8', 10:04:56 INFO - 'LANGUAGE': 'en_US:en', 10:04:56 INFO - 'LOGNAME': 'cltbld', 10:04:56 INFO - 'MAIL': '/var/mail/cltbld', 10:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:56 INFO - 'MOZ_NO_REMOTE': '1', 10:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:56 INFO - 'NO_EM_RESTART': '1', 10:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:56 INFO - 'PWD': '/builds/slave/test', 10:04:56 INFO - 'SHELL': '/bin/bash', 10:04:56 INFO - 'SHLVL': '1', 10:04:56 INFO - 'TERM': 'linux', 10:04:56 INFO - 'TMOUT': '86400', 10:04:56 INFO - 'USER': 'cltbld', 10:04:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:56 INFO - '_': '/tools/buildbot/bin/python'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 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 10:04:56 INFO - Cleaning up... 10:04:56 INFO - Return code: 0 10:04:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04:56 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')]} 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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')]} 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:04:56 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 10:04:56 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 10:04:56 INFO - Using env: {'DISPLAY': ':0', 10:04:56 INFO - 'HOME': '/home/cltbld', 10:04:56 INFO - 'LANG': 'en_US.UTF-8', 10:04:56 INFO - 'LANGUAGE': 'en_US:en', 10:04:56 INFO - 'LOGNAME': 'cltbld', 10:04:56 INFO - 'MAIL': '/var/mail/cltbld', 10:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:56 INFO - 'MOZ_NO_REMOTE': '1', 10:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:56 INFO - 'NO_EM_RESTART': '1', 10:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:56 INFO - 'PWD': '/builds/slave/test', 10:04:56 INFO - 'SHELL': '/bin/bash', 10:04:56 INFO - 'SHLVL': '1', 10:04:56 INFO - 'TERM': 'linux', 10:04:56 INFO - 'TMOUT': '86400', 10:04:56 INFO - 'USER': 'cltbld', 10:04:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:56 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Downloading/unpacking psutil>=0.7.1 10:04:57 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 10:04:57 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 10:04:57 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 10:04:57 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 10:04:57 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 10:04:57 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 10:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:59 INFO - Installing collected packages: psutil 10:04:59 INFO - Running setup.py install for psutil 10:04:59 INFO - building 'psutil._psutil_linux' extension 10:04:59 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 10:04:59 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 10:04:59 INFO - building 'psutil._psutil_posix' extension 10:04:59 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 10:04:59 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 10:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:59 INFO - Successfully installed psutil 10:04:59 INFO - Cleaning up... 10:04:59 INFO - Return code: 0 10:04:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:59 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:04:59 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 10:04:59 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 10:04:59 INFO - Using env: {'DISPLAY': ':0', 10:04:59 INFO - 'HOME': '/home/cltbld', 10:04:59 INFO - 'LANG': 'en_US.UTF-8', 10:04:59 INFO - 'LANGUAGE': 'en_US:en', 10:04:59 INFO - 'LOGNAME': 'cltbld', 10:04:59 INFO - 'MAIL': '/var/mail/cltbld', 10:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:59 INFO - 'MOZ_NO_REMOTE': '1', 10:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:59 INFO - 'NO_EM_RESTART': '1', 10:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:59 INFO - 'PWD': '/builds/slave/test', 10:04:59 INFO - 'SHELL': '/bin/bash', 10:04:59 INFO - 'SHLVL': '1', 10:04:59 INFO - 'TERM': 'linux', 10:04:59 INFO - 'TMOUT': '86400', 10:04:59 INFO - 'USER': 'cltbld', 10:04:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:59 INFO - '_': '/tools/buildbot/bin/python'} 10:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:59 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 10:04:59 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 10:04:59 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 10:04:59 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 10:04:59 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 10:04:59 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 10:05:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:01 INFO - Installing collected packages: mozsystemmonitor 10:05:01 INFO - Running setup.py install for mozsystemmonitor 10:05:01 INFO - Successfully installed mozsystemmonitor 10:05:01 INFO - Cleaning up... 10:05:01 INFO - Return code: 0 10:05:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:01 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:01 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 10:05:01 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 10:05:01 INFO - Using env: {'DISPLAY': ':0', 10:05:01 INFO - 'HOME': '/home/cltbld', 10:05:01 INFO - 'LANG': 'en_US.UTF-8', 10:05:01 INFO - 'LANGUAGE': 'en_US:en', 10:05:01 INFO - 'LOGNAME': 'cltbld', 10:05:01 INFO - 'MAIL': '/var/mail/cltbld', 10:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:01 INFO - 'MOZ_NO_REMOTE': '1', 10:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:01 INFO - 'NO_EM_RESTART': '1', 10:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:01 INFO - 'PWD': '/builds/slave/test', 10:05:01 INFO - 'SHELL': '/bin/bash', 10:05:01 INFO - 'SHLVL': '1', 10:05:01 INFO - 'TERM': 'linux', 10:05:01 INFO - 'TMOUT': '86400', 10:05:01 INFO - 'USER': 'cltbld', 10:05:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:01 INFO - '_': '/tools/buildbot/bin/python'} 10:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 INFO - Downloading docopt-0.6.1.tar.gz 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:04 INFO - Running setup.py install for blobuploader 10:05:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:04 INFO - Running setup.py install for requests 10:05:05 INFO - Running setup.py install for docopt 10:05:05 INFO - Successfully installed blobuploader requests docopt 10:05:05 INFO - Cleaning up... 10:05:05 INFO - Return code: 0 10:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:05 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')]} 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 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')]} 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:05 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 10:05:05 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 10:05:05 INFO - Using env: {'DISPLAY': ':0', 10:05:05 INFO - 'HOME': '/home/cltbld', 10:05:05 INFO - 'LANG': 'en_US.UTF-8', 10:05:05 INFO - 'LANGUAGE': 'en_US:en', 10:05:05 INFO - 'LOGNAME': 'cltbld', 10:05:05 INFO - 'MAIL': '/var/mail/cltbld', 10:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:05 INFO - 'MOZ_NO_REMOTE': '1', 10:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:05 INFO - 'NO_EM_RESTART': '1', 10:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:05 INFO - 'PWD': '/builds/slave/test', 10:05:05 INFO - 'SHELL': '/bin/bash', 10:05:05 INFO - 'SHLVL': '1', 10:05:05 INFO - 'TERM': 'linux', 10:05:05 INFO - 'TMOUT': '86400', 10:05:05 INFO - 'USER': 'cltbld', 10:05:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:05 INFO - '_': '/tools/buildbot/bin/python'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:05 INFO - Running setup.py (path:/tmp/pip-LO4gjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:05 INFO - Running setup.py (path:/tmp/pip-e3CKsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:05 INFO - Running setup.py (path:/tmp/pip-jj5Sbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:05 INFO - Running setup.py (path:/tmp/pip-9KPuxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:05 INFO - Running setup.py (path:/tmp/pip-fLNlRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:05 INFO - Running setup.py (path:/tmp/pip-VWOUvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:06 INFO - Running setup.py (path:/tmp/pip-L9_xx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:06 INFO - Running setup.py (path:/tmp/pip-pFJwCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:06 INFO - Running setup.py (path:/tmp/pip-POt3LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:06 INFO - Running setup.py (path:/tmp/pip-9BKegt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:06 INFO - Running setup.py (path:/tmp/pip-6ucFfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:06 INFO - Running setup.py (path:/tmp/pip-y3K_UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:06 INFO - Running setup.py (path:/tmp/pip-sNfHgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:06 INFO - Running setup.py (path:/tmp/pip-Nnihfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:06 INFO - Running setup.py (path:/tmp/pip-GiGCBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:06 INFO - Running setup.py (path:/tmp/pip-P5Rq1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:06 INFO - Running setup.py (path:/tmp/pip-ntZroc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:06 INFO - Running setup.py install for manifestparser 10:05:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:06 INFO - Running setup.py install for mozcrash 10:05:06 INFO - Running setup.py install for mozdebug 10:05:07 INFO - Running setup.py install for mozdevice 10:05:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozfile 10:05:07 INFO - Running setup.py install for mozhttpd 10:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozinfo 10:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozInstall 10:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozleak 10:05:07 INFO - Running setup.py install for mozlog 10:05:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for moznetwork 10:05:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozprocess 10:05:08 INFO - Running setup.py install for mozprofile 10:05:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for mozrunner 10:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for mozscreenshot 10:05:08 INFO - Running setup.py install for moztest 10:05:08 INFO - Running setup.py install for mozversion 10:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:08 INFO - Cleaning up... 10:05:08 INFO - Return code: 0 10:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:08 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:08 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 10:05:08 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 10:05:08 INFO - Using env: {'DISPLAY': ':0', 10:05:08 INFO - 'HOME': '/home/cltbld', 10:05:08 INFO - 'LANG': 'en_US.UTF-8', 10:05:08 INFO - 'LANGUAGE': 'en_US:en', 10:05:08 INFO - 'LOGNAME': 'cltbld', 10:05:08 INFO - 'MAIL': '/var/mail/cltbld', 10:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:08 INFO - 'MOZ_NO_REMOTE': '1', 10:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:08 INFO - 'NO_EM_RESTART': '1', 10:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:08 INFO - 'PWD': '/builds/slave/test', 10:05:08 INFO - 'SHELL': '/bin/bash', 10:05:08 INFO - 'SHLVL': '1', 10:05:08 INFO - 'TERM': 'linux', 10:05:08 INFO - 'TMOUT': '86400', 10:05:08 INFO - 'USER': 'cltbld', 10:05:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:08 INFO - '_': '/tools/buildbot/bin/python'} 10:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:08 INFO - Running setup.py (path:/tmp/pip-mZViqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:08 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)) 10:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:08 INFO - Running setup.py (path:/tmp/pip-0AWoEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:08 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)) 10:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:08 INFO - Running setup.py (path:/tmp/pip-rrZHL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:09 INFO - Running setup.py (path:/tmp/pip-vwBMOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:09 INFO - Running setup.py (path:/tmp/pip-WnnBLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:09 INFO - Running setup.py (path:/tmp/pip-mMCIo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:09 INFO - Running setup.py (path:/tmp/pip-KIrtKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:09 INFO - Running setup.py (path:/tmp/pip-C3wUos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:09 INFO - Running setup.py (path:/tmp/pip-1qGvaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:09 INFO - Running setup.py (path:/tmp/pip-LSsiqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:09 INFO - Running setup.py (path:/tmp/pip-JfcDKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:09 INFO - Running setup.py (path:/tmp/pip-yRgLB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:09 INFO - Running setup.py (path:/tmp/pip-5vCCzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:09 INFO - Running setup.py (path:/tmp/pip-nCjWLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:09 INFO - Running setup.py (path:/tmp/pip-w1p3BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:09 INFO - Running setup.py (path:/tmp/pip-oiJ0gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:09 INFO - Running setup.py (path:/tmp/pip-zqj9CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:11 INFO - Downloading blessings-1.6.tar.gz 10:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:11 INFO - Installing collected packages: blessings 10:05:11 INFO - Running setup.py install for blessings 10:05:12 INFO - Successfully installed blessings 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:12 INFO - Reading from file tmpfile_stdout 10:05:12 INFO - Current package versions: 10:05:12 INFO - argparse == 1.2.1 10:05:12 INFO - blessings == 1.6 10:05:12 INFO - blobuploader == 1.2.4 10:05:12 INFO - docopt == 0.6.1 10:05:12 INFO - manifestparser == 1.1 10:05:12 INFO - mozInstall == 1.12 10:05:12 INFO - mozcrash == 0.17 10:05:12 INFO - mozdebug == 0.1 10:05:12 INFO - mozdevice == 0.48 10:05:12 INFO - mozfile == 1.2 10:05:12 INFO - mozhttpd == 0.7 10:05:12 INFO - mozinfo == 0.9 10:05:12 INFO - mozleak == 0.1 10:05:12 INFO - mozlog == 3.1 10:05:12 INFO - moznetwork == 0.27 10:05:12 INFO - mozprocess == 0.22 10:05:12 INFO - mozprofile == 0.28 10:05:12 INFO - mozrunner == 6.11 10:05:12 INFO - mozscreenshot == 0.1 10:05:12 INFO - mozsystemmonitor == 0.0 10:05:12 INFO - moztest == 0.7 10:05:12 INFO - mozversion == 1.4 10:05:12 INFO - psutil == 3.1.1 10:05:12 INFO - requests == 1.2.3 10:05:12 INFO - wsgiref == 0.1.2 10:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 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 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:12 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 10:05:12 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 10:05:12 INFO - Using env: {'DISPLAY': ':0', 10:05:12 INFO - 'HOME': '/home/cltbld', 10:05:12 INFO - 'LANG': 'en_US.UTF-8', 10:05:12 INFO - 'LANGUAGE': 'en_US:en', 10:05:12 INFO - 'LOGNAME': 'cltbld', 10:05:12 INFO - 'MAIL': '/var/mail/cltbld', 10:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:12 INFO - 'MOZ_NO_REMOTE': '1', 10:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:12 INFO - 'NO_EM_RESTART': '1', 10:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:12 INFO - 'PWD': '/builds/slave/test', 10:05:12 INFO - 'SHELL': '/bin/bash', 10:05:12 INFO - 'SHLVL': '1', 10:05:12 INFO - 'TERM': 'linux', 10:05:12 INFO - 'TMOUT': '86400', 10:05:12 INFO - 'USER': 'cltbld', 10:05:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:12 INFO - '_': '/tools/buildbot/bin/python'} 10:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:12 INFO - Using env: {'DISPLAY': ':0', 10:05:12 INFO - 'HOME': '/home/cltbld', 10:05:12 INFO - 'LANG': 'en_US.UTF-8', 10:05:12 INFO - 'LANGUAGE': 'en_US:en', 10:05:12 INFO - 'LOGNAME': 'cltbld', 10:05:12 INFO - 'MAIL': '/var/mail/cltbld', 10:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:12 INFO - 'MOZ_NO_REMOTE': '1', 10:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:12 INFO - 'NO_EM_RESTART': '1', 10:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:12 INFO - 'PWD': '/builds/slave/test', 10:05:12 INFO - 'SHELL': '/bin/bash', 10:05:12 INFO - 'SHLVL': '1', 10:05:12 INFO - 'TERM': 'linux', 10:05:12 INFO - 'TMOUT': '86400', 10:05:12 INFO - 'USER': 'cltbld', 10:05:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:12 INFO - '_': '/tools/buildbot/bin/python'} 10:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:12 INFO - Downloading/unpacking jsonschema 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:14 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:14 INFO - warning: no files found matching '*.txt' 10:05:14 INFO - no previously-included directories found matching 'build' 10:05:14 INFO - no previously-included directories found matching 'dist' 10:05:14 INFO - no previously-included directories found matching '.git*' 10:05:14 INFO - Installing collected packages: jsonschema, functools32 10:05:14 INFO - Running setup.py install for functools32 10:05:15 INFO - warning: no files found matching '*.txt' 10:05:15 INFO - no previously-included directories found matching 'build' 10:05:15 INFO - no previously-included directories found matching 'dist' 10:05:15 INFO - no previously-included directories found matching '.git*' 10:05:15 INFO - Successfully installed jsonschema functools32 10:05:15 INFO - Cleaning up... 10:05:15 INFO - Return code: 0 10:05:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7656f21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, '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': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', '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 10:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:05:15 INFO - Using env: {'DISPLAY': ':0', 10:05:15 INFO - 'HOME': '/home/cltbld', 10:05:15 INFO - 'LANG': 'en_US.UTF-8', 10:05:15 INFO - 'LANGUAGE': 'en_US:en', 10:05:15 INFO - 'LOGNAME': 'cltbld', 10:05:15 INFO - 'MAIL': '/var/mail/cltbld', 10:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:15 INFO - 'MOZ_NO_REMOTE': '1', 10:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:15 INFO - 'NO_EM_RESTART': '1', 10:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:15 INFO - 'PWD': '/builds/slave/test', 10:05:15 INFO - 'SHELL': '/bin/bash', 10:05:15 INFO - 'SHLVL': '1', 10:05:15 INFO - 'TERM': 'linux', 10:05:15 INFO - 'TMOUT': '86400', 10:05:15 INFO - 'USER': 'cltbld', 10:05:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:15 INFO - '_': '/tools/buildbot/bin/python'} 10:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:15 INFO - Downloading/unpacking flake8 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:17 INFO - no previously-included directories found matching 'docs/_build' 10:05:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:18 INFO - Running setup.py install for pep8 10:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:18 INFO - no previously-included directories found matching 'docs/_build' 10:05:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:18 INFO - Cleaning up... 10:05:18 INFO - Return code: 0 10:05:18 INFO - Running post-action listener: _resource_record_post_action 10:05:18 INFO - Running post-action listener: _start_resource_monitoring 10:05:18 INFO - Starting resource monitoring. 10:05:18 INFO - ##### 10:05:18 INFO - ##### Running install step. 10:05:18 INFO - ##### 10:05:18 INFO - Running pre-action listener: _resource_record_pre_action 10:05:18 INFO - Running main action method: install 10:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:18 INFO - Reading from file tmpfile_stdout 10:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:18 INFO - Reading from file tmpfile_stdout 10:05:18 INFO - Output received: 10:05:18 INFO - Usage: mozinstall [options] installer 10:05:18 INFO - Options: 10:05:18 INFO - -h, --help show this help message and exit 10:05:18 INFO - -d DEST, --destination=DEST 10:05:18 INFO - Directory to install application into. [default: 10:05:18 INFO - "/builds/slave/test"] 10:05:18 INFO - --app=APP Application being installed. [default: firefox] 10:05:18 INFO - mkdir: /builds/slave/test/build/application 10:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:05:34 INFO - Reading from file tmpfile_stdout 10:05:34 INFO - Output received: 10:05:34 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:34 INFO - Running post-action listener: _resource_record_post_action 10:05:34 INFO - ##### 10:05:34 INFO - ##### Running run-tests step. 10:05:34 INFO - ##### 10:05:34 INFO - Running pre-action listener: _resource_record_pre_action 10:05:34 INFO - Running main action method: run_tests 10:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:34 INFO - Python 2.7.3 10:05:34 INFO - Return code: 0 10:05:34 INFO - grabbing minidump binary from tooltool 10:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:05:34 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 0x1eb1410>, '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 0x1eb2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:34 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 10:05:34 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 10:05:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:34 INFO - Return code: 0 10:05:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:35 INFO - Return code: 0 10:05:35 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/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 10:05:35 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/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 10:05:35 INFO - Using env: {'DISPLAY': ':0', 10:05:35 INFO - 'HOME': '/home/cltbld', 10:05:35 INFO - 'LANG': 'en_US.UTF-8', 10:05:35 INFO - 'LANGUAGE': 'en_US:en', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MAIL': '/var/mail/cltbld', 10:05:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SHLVL': '1', 10:05:35 INFO - 'TERM': 'linux', 10:05:35 INFO - 'TMOUT': '86400', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - '_': '/tools/buildbot/bin/python'} 10:05:35 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/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 10:05:35 INFO - mozversion application_buildid: 20160429091131 10:05:35 INFO - mozversion application_changeset: cc898e5dfa22a5263e34488baccd32c2ca275f30 10:05:35 INFO - mozversion application_display_name: Nightly 10:05:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:35 INFO - mozversion application_name: Firefox 10:05:35 INFO - mozversion application_remotingname: firefox 10:05:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:05:35 INFO - mozversion application_vendor: Mozilla 10:05:35 INFO - mozversion application_version: 49.0a1 10:05:35 INFO - mozversion platform_buildid: 20160429091131 10:05:35 INFO - mozversion platform_changeset: cc898e5dfa22a5263e34488baccd32c2ca275f30 10:05:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:35 INFO - mozversion platform_version: 49.0a1 10:05:35 INFO - using testdate: 1461949535 10:05:35 INFO - actual date: 1461949535 10:05:35 INFO - starting webserver on 'localhost:53341' 10:05:35 INFO - SUITE-START | Running 2 tests 10:05:35 INFO - TEST-START | dromaeo_css 10:05:35 INFO - operating with platform_type : linux_ 10:05:35 INFO - Initialising browser for dromaeo_css test... 10:05:35 INFO - TEST-INFO | started process 12601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrEs9K/profile http://localhost:53341/getInfo.html) 10:05:39 INFO - PROCESS | 12601 | __metrics Screen width/height:1600/1200 10:05:39 INFO - PROCESS | 12601 | colorDepth:24 10:05:39 INFO - PROCESS | 12601 | Browser inner width/height: 1024/697 10:05:39 INFO - PROCESS | 12601 | __metrics 10:05:40 ERROR - PROCESS | 12601 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:05:41 INFO - TEST-INFO | 12601: exit 0 10:05:41 INFO - Browser initialized. 10:05:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:41 INFO - TEST-INFO | started process 12681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrEs9K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:53 INFO - PROCESS | 12681 | RSS: Main: 156426240 10:05:53 INFO - PROCESS | 12681 | 10:06:44 INFO - PROCESS | 12681 | 1461949604914 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] 10:08:57 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53341/tests/dromaeo/cssquery-ext.html) 10:08:58 INFO - PROCESS | 12681 | RSS: Main: 235085824 10:08:58 INFO - PROCESS | 12681 | 10:12:01 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-ext.html (next: http://localhost:53341/tests/dromaeo/cssquery-jquery.html) 10:12:02 INFO - PROCESS | 12681 | RSS: Main: 239415296 10:12:02 INFO - PROCESS | 12681 | 10:15:04 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53341/tests/dromaeo/cssquery-mootools.html) 10:15:04 INFO - PROCESS | 12681 | RSS: Main: 238968832 10:15:04 INFO - PROCESS | 12681 | 10:18:07 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53341/tests/dromaeo/cssquery-prototype.html) 10:18:07 INFO - PROCESS | 12681 | RSS: Main: 236384256 10:18:07 INFO - PROCESS | 12681 | 10:21:10 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53341/tests/dromaeo/cssquery-yui.html) 10:21:11 INFO - PROCESS | 12681 | RSS: Main: 219475968 10:21:11 INFO - PROCESS | 12681 | 10:24:13 INFO - PROCESS | 12681 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-yui.html (next: http://localhost:53341/tests/dromaeo/cssquery-dojo.html) 10:24:14 INFO - PROCESS | 12681 | RSS: Main: 271364096 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | __start_tp_report 10:24:14 INFO - PROCESS | 12681 | _x_x_mozilla_page_load 10:24:14 INFO - PROCESS | 12681 | _x_x_mozilla_page_load_details 10:24:14 INFO - PROCESS | 12681 | |i|pagename|runs| 10:24:14 INFO - PROCESS | 12681 | |0;dojo.html;2604.778593819525;2677.611746296786;2677.692065412477;2695.0567301444485;2714.2671478700745;4499.437570303712;4620.491745907947;4633.976830115849;4636.976815115924;4651.767411629414;4588.197065513538;4623.398958135438;4636.814527418899;4640.651951103664;4655.7439340836245;4255.765932873691;4271.850485233025;4316.2662347400865;4321.9783901080455;4437.622802061828;4339.956600434002;4368.563143685637;4382.342648602703;4382.561743825624;4429.1806015887005;4183;4236.68224883135;4262.722923009995;4268.466441694788;4316.438862947828;4293.592108749695;4298.204832106039;4304.096139810612;4314.201872653569;4353.912921741579;4274;4278;4280.036991676879;4314.7411155330465;4318.762468064255;4404.779761011969;4541.409616749835;4560.657950653681;4610.631149508032;4616.215243408628;4956.08312462192;4966.478519755446;4982.476839931827;5005.9499405005845;5027.044861476308;4898.093852637274;4976.328195693572;4978.303037574742;4982.227754698028;4983.302337672729;4608.539146085398;4627.838025669085;4629.1436084324505;4681.555252251031;4687.2500399936525;5013.799448022039;5036.697798132123;5036.84889453317;5043.5965122790085;5082.415522214918;4662.114198302312;4809.591184749335;4836.298736683231;4837.298591704183;4888.144574699413;4941.65408421407;4978.327925730053;4978.6763860348965;5009.474005229398;5015.899682006412;4889.804407823647;4896.828610998598;4897.094037603055;4902.926456103161;4933.481984391659;4762.52374762521;4852.927206091911;4877.902441951142;4939.678920870132;4952.504749525018;4220.514640816284;4226.070264541796;4230.090530535949;4255.106427650167;4266.573342665709;3665.193657395369;3681.4109742441083;3695.8152092395812;3720.9627903721157;3736.7197460190596;4159.459270294842;4233.195692818416;4264.936025959613;4279.379489973936;4322.524522302544;4945.703257804544;4972.776225069881;4975.129352363322;5002.499750024968;5010.248462730619;4244.151169765997;4245.830166793356;4249.957500424956;4289.592488713567;4294.162638285505;4380.518143004267;4382.9342559861625;4428.844990425384;4446.555344465528;4449.933251001237;4665.626749860071;4680.4149481314835;4692.6480513960905;4709.9529004710885;4735.195016847076;4954.430240522242;4954.653174277766;4961.925571116509;4966.329545511454;5022.447530771686;4551.5676010778925;4689.343491911203;4692.50728673498;4761.619070474423;4778.474367819467;4833.540813622841;4838;4843;4848.418189817245;4896.11869863428;4874.95125048745;4900.14247506692;4903.092927808367;4907.730074845917;4950.133726597759;4672.065586882569;4797.520247975174;4815.975920120377;4862.5380588844;4865.270209468608;4815.975920120377;4834.5890599299455;4836.12949669063;4838.7338696372035;4882.072406242803;4591.173588753923;4742.407199100113;4744.3357929890535;4750.453697824656;4792.496787837366;4823.2282834746275;4864.197407427876;4879.585235254901;4906.975465122651;4917.975410122926;4694.507076756891;4718.386609740712;4722.834700785456;4735.928961065518;4771.260454629538 10:24:14 INFO - PROCESS | 12681 | |1;ext.html;595.5890435599437;604.9667268300242;614.3549273263076;621.3506885304856;635.4693830651406;33130.50304245435;34510.65489345106;34573.135671608194;34625.48061779075;34656;35991.640083599224;36726.26547469049;36753.632463675356;36794.63205367945;36808.63191368085;7285.162206346258;7540.924590754104;7659.502132361406;7681.3470854977395;9603.087706667855;9735.951320243388;9886.307958442912;9910;9920.950395248014;9930.162919859813;9840.212782977345;10038.74903127424;10047.095761381473;10053.94973025134;10055.547500362465;7215.494915355954;9540.666076687352;9787.46168960707;9787.90212097884;9867;9424.90575094254;9557.61769529218;9558.856617150748;9567.760805979837;9570.186534144606;34086.318273634635;34855.651443485745;34943.30113397743;34957.12607184815;34959.30081398358;3075.138961090876;3082;3099.891503797356;3289.161263877696;3339.2653616204398;26455.867720661467;28639.14082577526;28855.278618034507;29353.559696604567;29418.11745647634;3309.1396236978317;3381.3744457275484;3384.2554637979606;3402.302527981758;3417.5215469834243;242094;246235.9999999982;246553;246960;247611;53874.46125538773;54668.72665636647;54768;54793.452065478836;54800.45199548033;49382.25926611104;49969.75015124974;50267.74866125646;50283;50337.24494132591;14512.1292722437;14638.853611463748;14728.779068313985;14729.92635036818;14750.778738318933;9821.607135714634;10668.89331106679;10862.511186996604;10949.124070074535;10966.506507207196;18015.819841801676;18177.182026808827;18699.158537865827;18853.434396968114;18908.81091189098;6683.699233534503;6779.49153813466;6781.491388145811;7029.507934444642;7115.715371385087;888.0852721696663;922.0180507759216;929.6049179098991;946.0870260198941;992.6873034993954;27798.25218476904;28410.289742756595;28512.572311415344;28752.712472875002;28970.27574310659;986.4229425785852;1003.2325271167563;1027.6146445083093;1055.7993981143711;1144.296257801446;14772.18752968597;14885.255737213096;15302.923485382724;15448.304826282843;15586.298616562282;387052;394312;394646.34798738564;394658;395133;48879.26681099786;49641.255381169314;49725.75137124291;49733;49880;1153.6135394642888;1181.5923506390454;1214.6173955204083;1229.213303485752;1254.1033161289722;24655.260342189762;25749;25911.740882590933;26059.478810423305;26070.34824129336;35287;35365.29269414649;35663.82168089143;35677.46483802797;35755.46366804552;228346;230169;230451;230529;230616;21071.683924741446;23172.768272317735;23520.647190291817;23545.29364119079;25527.872360638077;35655.46516802198;35772.821135894155;35868;36637.08407289839;36854.44718329281;32004.35991280115;34155.316893662486;34429;35153.296934060665;35427.46858797069;33399.33201336008;33589.83205083959;33815.66184338224;33979.66020339765;34337.31325373529;33702.3259534803;34220;34392.14019649529;34425.31149377049;34451.82774086113;30968.225794355323;31032;31206.21984450407;31354.29685547186;31476.527852082694;24272.393190170387;24362.51274974526;24780.752192477845;24836.503269934863;24944 10:24:14 INFO - PROCESS | 12681 | |2;jquery.html;374.22161903241255;380.7924681048828;383.6796275110283;386.79113278829425;388.32625394939794;15892.682146357067;16533.503994880157;17433.47699569015;17443.825561744412;17459.650806983853;15924.920375398136;16428.67142657146;16732.66534669306;16740.748888766677;16768.74846877295;3475.8957231282975;4543.136804007237;4760.262159365304;4760.952390476103;4765.761711914408;3609.819509024538;5134.229865520165;5481.369642491125;5485.232067510552;5493.587980901429;5466.753996070186;5466.835994920159;5478.671279723209;5480.342358916935;5755.136729490589;5896.115582662592;6029.577929544934;6051.818445446644;6060.575759696801;6061.939380606182;3407.4377727674905;3574.5353104096303;3579.8031108289033;3585.713142948558;5028.7988480460735;11975.880241197563;12240.938795306056;12329.69175770604;12338.629841104692;12716.872831271661;1913.2538310059088;2007.4278830533228;2064.298138632872;2177.912883484659;2320.8143348532076;8777.824443511157;9042.638294468214;9157.587908544132;9373.718788436357;9523.095305945924;1691.8815682902202;1734.7137722275809;1770.1680210301138;1778.3242367900245;1800.621869407426;65255.347446525404;71055.64472177658;72151.63924180398;72927;73074;9857.408555486694;10120.190384769201;10153;10195.541200645988;10307.278490505743;14234.715305694035;14274;14333.498327558695;14361.856381436051;14374.353154107881;6953.33943275388;7122.893156602655;7169.5698258104685;7232.963835180791;7249.093863267091;6729.932700672931;6786;6860.451163906875;6894.862102757917;6918.757843475454;4256.531781504032;4277.2942464493635;4291.935620965688;4334.393184954109;4471.8434854779925;1707.1720215695377;1794.452691928948;1822.6354729054242;1851.1118658967778;1858.3402891973426;793.4683761879554;840.1304649687544;900.4597241654955;923.422860712055;941.8398872191607;15511.922440387725;16243;16640.916795416186;16733.330666773192;17172.570685732957;924.9352545321763;927.3508544019213;930.6882194464795;965.8599503072015;970.9611615535299;9195;9199.310051746146;9475.763105922408;9497.24022078246;9618.807623847484;380178;391739;394669;395533;396680;73489;75895.62052189704;79230.94589062371;81044;82144;907.5235501361706;910.5037754423855;918.5040078357746;932.9813403731887;935.8034812689411;14665.92667036658;14742.11547307165;14831.92584037073;14924.328405221573;14987.700245994802;33389;33875;34444.31111377809;34752;35415.11462213465;47248.76375618237;48620.513794861596;49601.75199123981;49958.75020624873;50817.49182508128;7747.92252077472;7789.376849851885;7803.531788092732;7819.41354398411;7856.5678887661725;10117.29178957466;10716.303440276357;11073.723156921142;11143.609973650884;11219.60731374398;9251.67619133354;9392.718218453458;9481.288903332415;9664.516774161124;9688.5640146195;9602.567884445356;9676.75808104803;9699.127078562964;9739.610415583298;9792.951035244778;9395.201407880133;9466.621335146792;9486.383385079947;9513.381630194015;10007.39955602637;7625.161232264336;7659.463837531319;7739.613019349123;7827.373810095065;7931.36549076061;8255.752327430188;9177.77055573616;9325.114114159143;9362.063793620584;9562.904370956201 10:24:14 INFO - PROCESS | 12681 | |3;mootools.html;1297.1698113207542;1449.0653528474131;1470.0077447722788;1557.1513525128803;1741.9825801741986;6709.832254193648;7488.663010164542;7733.961330193341;7759.340456061242;7761.844763104735;7523.924760752391;7700.306972372486;7715.382769378451;7717.421193410502;7720.189380115091;1850.3523766681687;1899.4301709487167;1904.419152158591;2224.0992398078765;2261.4233370490583;2184.2682701295007;2260.762619924909;2262.3891549281684;2262.988685056581;2264.479169790949;2200.7799220078023;2208.039502816272;2215.966760498594;2217.6230040893006;2259.807916327114;1922.7692676878723;2159.546495236002;2203.724534433196;2214.833887458431;2215.4239897626653;2221.3224966385246;2234.765349638281;2242.9102835886547;2243.955120897573;2244.8204143668468;7543.283388078124;7583.924160758377;7601.733939312153;7608.201138880393;7612.467127301091;4436.600705936449;4587.977060114678;4611.861644150681;4616.976915115437;4618.330342100377;2854.1152242804797;2984.686607906182;3003.1591154476782;3016.351484430858;3030.272734543694;914.826183025223;942.9528523573863;948;984.0553069053717;993.7913038261973;10820.404877731722;10820.945895270552;10854.34873907568;10861.891381086167;10881.12950963921;4250.362445633118;4334.674899382559;4378.058717375779;4412.073464572476;4418.381426600278;9145.49699766506;9148.085191480932;9157.221636160868;9160.725178244664;9171.35800493959;4718.433787945469;4729.337892695025;4734.053189362141;4736.668433209711;4743.501932297128;3746.6815320698047;4115.094679170577;4254.532001479834;4262.211490874198;4343.587359200871;3667.9266414672093;3693.8337774800198;3751.8311675974646;3763.34141525232;3822.197338558878;1220.109320196244;1227.2268470863478;1230.4032544216047;1236.6908272931767;1242.3539759325101;871.4945331707594;872.6858331000834;874.5539774714941;897.1880448194395;902.5036230073433;5342.839714808562;5349.384820745586;5401.270828438189;5529.834104976777;5638.984982703071;873.5763154869883;904.2359206470522;918.4764684130115;926.9397489163183;928.5589345061042;3675;3693.464447655129;3700.7039436845525;3761.6990640748672;3768.660820526166;9431.528423578793;9782.266330025277;9857.309988300893;9864.605415783288;9963.750906227257;9691.903080969241;9695.709128726008;9755.951220243995;9835.950820245853;9863.260255480867;6933.5493192942295;7086.893696594555;7268.127824660969;7320.926790732131;7323.487355885143;5343.118385466354;5377.865553361197;5437.4018857926385;5464.617476776588;5520.447955204448;8627.180417860292;8825.823483530165;8909.1536304051;8928.15182557656;8957.328200384867;8619;8930.687425940321;9038.32212584072;9055.366124371494;9210.171084602418;6835.69239384219;6857.348551887562;6957.965210173917;7166.8924966124505;7169.139703235645;7408.740694075682;7433.145188303198;7461.701531938662;7476.887846682413;7502.737404190827;6890.138732658418;7066.929330706627;7113.253108423748;7113.324234197743;7231.3130252625915;6883.346082122191;6891.207511136284;6933.1333583302085;6962.686679099554;6981;6395.744170233139;6412.294647588668;6420.2937676856445;6446.967765161145;6450.774222902176;4735.12400205963;4740.312654665123;4753.619710423227;4854.538818812207;4919.843836698445;4689.742064186503;4779.498152693917;4853.635977301646;4864.294677271847;4885.951140488692 10:24:14 INFO - PROCESS | 12681 | |4;prototype.html;293.3224251977932;308.22020288669665;310.1393632669343;312.362779928945;314.3979279679414;4630.536946305368;4679.555442232987;4738.97630511847;4764.023375208083;4809.773507755522;4600.217962946299;4752.310914917335;4790.449098353691;4794.208955522335;4800.927986080203;3808.885733427988;3815.3704638734644;3824.9043773905737;3841;3893.3770596704535;3591.8024508652015;3669.174435751961;3807.200487897545;3810.618938106195;3848.1726428817797;3771.18919432322;3779.4315359126067;3841.7694938303653;3844.3272427325105;3844.3272427325246;3777.7922214278206;3787.280416720814;3791.2227993261317;3793.6206379361843;3813.427985802124;3398.4052790761516;3402.35355282498;3410.658934106594;3426.777259478126;3436.8281585920604;4420.46954365475;4539.795709193094;4569.286517555916;4590.770461476913;4591.931121033187;4325.372820940977;4335.263005289108;4346.8043938022865;4353.432764204884;4387.978060109711;4987.725675087869;4989.476105008995;4993.525615066563;5004.874878128039;5008.1486147355035;3624.1302087499075;3694.1688120173017;3714.0900479382453;3718.5909549949483;3740.9812950935343;5142.07442660321;5200.6879587224885;5227.947720522822;5237.371515418175;5249.4488078751565;3787.5644300905196;3816.1413681921345;3825.062859599416;3826.559945606235;3834.8716462363655;3607.549056367954;3856.5950575189763;3886.5336159661024;3889.902752431212;3913.4325522799036;4284.8500302489265;4300.526942036374;4331.28914078937;4349.3041113421705;4363.38912552243;5007.198848184273;5014.247862820606;5015.498450154955;5038;5063.544281014652;1310.7444048410468;1360.59182245326;1364.6929440875724;1409.2390109341045;1410.4076287959083;959.1799011844772;965.8309795785709;975.4342481360794;977.7213494154132;986.5166068626465;4626.86119416418;4650.279396623271;4651.767411629405;4654.325122857167;4672.369230153954;5416.702081385482;5439.564834813205;5442.292501974718;5480.80817171405;5481.342238931354;4253.872723728215;4621.313220674429;4622.699524530894;4635.976820115878;4644.651651126179;2935.9853200734287;2951.4982452983045;2957.6746557878614;2962.688917663614;2984.4627966965722;5225.1378522543355;5235.921461178085;5255.290535777697;5263.210518422267;5268.762905669254;5459.235707001023;5686.943130568724;5702.7433765480655;5704.515116215168;5720.11338242573;5193.740312984336;5230.869228269247;5231.686098834006;5234.816781412632;5247.868803279948;5549.528290095387;5554.416786237387;5557.610967232255;5570.192322113352;5577.9442205577425;5316.707581082923;5418.753686652013;5464.371597266365;5480.972595136999;5500.367457742411;5234.97382513085;5244.213367994831;5245.108331583716;5267.551423358607;5277.2875661785165;3863.4011728182177;3869.5163104611925;3878.631530004645;3879.3792993120965;3899.434581985653;4906;5354.54486368663;5502.339719233718;5545.805896793593;5547.1679248113105;4838.709677419366;5020.598352131894;5024.84925452237;5029.295898574275;5038.773255203451;4991.5008499151245;5013.448520662797;5018.774155162953;5031.84904452867;5037.848864534069;4831.154547954165;4925.1381008324115;4925.38432695913;4935.531124543163;4970.975145124396;5009.323741294878;5018.247262910592;5030.748462576783;5045.344105266438;5064.696118232918;4913.385826771653;4932.28481870134;4933.457319694902;4938.506149385033;4948.802047918043 10:24:14 INFO - PROCESS | 12681 | |5;yui.html;608.7291155435831;638.4445532386821;659.6833519910446;697.1355519156248;740.6074780366407;10804.783904321908;10984.670459886196;10998.835017474725;11132.053775429098;11158.553657853687;11833.704157396069;11921.940390298036;11937.045036397089;12437.315947622878;12943.223406595587;802.7471346525825;803.1606970715616;805.532790981231;809.3039985612369;812.273015650992;635.2853040329629;756.8372799848031;782.2529484342467;783.7335305995961;805.3315747929234;828.2462958707578;833.0295206084904;836.4103307168432;836.506461187899;836.6946064686376;821.0721884270765;825.2531459029587;825.8678611422143;826.7230477789948;829.5478963964594;491.31461611052384;593.3413910559276;605.0742364182807;609.7500024989778;610.1518888744648;11633.70915727105;11703.882961170364;11737.647870563811;11750.177487575873;11758.353290569015;10849.837252441219;11200.887991120066;11351.772964540745;11367.488463019185;11544.942275288653;9622.903770962272;9669.274804389628;9670.75823104421;9840.311178217527;9940.353876997971;3136.168915237464;3147.2289289124083;3152.448321543721;3155.9053228403186;3196.4406228909847;44799.77600112011;45392.77303613461;45525.772371138264;45857.312140317925;46561.30158047632;7857.882131768028;8999.77500562478;9011.188992990663;9095.863562046574;9147.176754092163;16343.019418834909;16516.669666606602;16538.917305413637;16540.338386464406;16584.66830663404;6433.613983161025;6461.256955450183;6504.38208370204;6539.607623542603;6591;3701.3522633539023;3734.477173195755;3737.3085979093953;3760.8495660173285;3788.6400791924725;2682.8524431156475;2743.1359121876544;2743.670759508832;2749.8075134740775;2750.339918419605;500.78215976050535;508.1437777345185;517.567830861235;517.818763432803;523.2883278740909;522.5662699959025;557.3562535271686;559.0775220885571;567.4637467593085;569.521601854436;7606.125295590967;7686.654100565488;7821;7931.5637639930355;8044.316233120133;435.31437985172846;511.52172718508314;592.9169916211733;611.3733423241214;615.7875532941129;3673;3746.9437958430644;3793.2223894101644;3874.2057878134915;3905.8437662493184;57307.426925731044;59017;59239.40760592425;59301;59430;52413.47586524162;53817;53906;54131.18803217955;54629;46711.766441168256;47001.05997880023;47192.29211561829;47371;48008;7162.46281528877;7319.926800732138;7384.778456646309;7451.2921272479025;7704.26809453101;27572.483513406954;27684.723152768216;28666;29057.41885162327;29769.851150744107;39234.803825980685;39302;40274;40747.1850562993;40931;10112.292139550162;10415.68752937413;10470.424126673106;10480.42357670305;10514.894851051391;10210.642627508001;10748.946255268673;10798.568057277935;10920.180986426209;11511.712207194887;10731.946340268249;11012.449377531251;11167.553297867995;11319.660410187707;11342.886571134182;10927.781444371227;11140.220184587;11207.43962801873;11432.599859005228;11904.226225295328;10307.536160872629;10884.61903833362;11014.669559913216;11096.5561377544;11630.709232268922;9454.432734035705;9524.238060955246;9606.855897161407;9798.51007449639;9838.26213034011;9290.674826381044;9331.626734930798;9437.346889084374;9547.33168678186;9567.569459374206 10:24:14 INFO - PROCESS | 12681 | __end_tp_report 10:24:14 INFO - PROCESS | 12681 | __start_cc_report 10:24:14 INFO - PROCESS | 12681 | _x_x_mozilla_cycle_collect,902 10:24:14 INFO - PROCESS | 12681 | __end_cc_report 10:24:14 INFO - PROCESS | 12681 | __startTimestamp1461950654085__endTimestamp 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | ------- Summary: start ------- 10:24:14 INFO - PROCESS | 12681 | Number of tests: 6 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#0] dojo.html Cycles:165 Average:4581.37 Median:4692.51 stddev:458.69 (9.8%) stddev-sans-first:433.09 10:24:14 INFO - PROCESS | 12681 | Values: 2604.8 2677.6 2677.7 2695.1 2714.3 4499.4 4620.5 4634.0 4637.0 4651.8 4588.2 4623.4 4636.8 4640.7 4655.7 4255.8 4271.9 4316.3 4322.0 4437.6 4340.0 4368.6 4382.3 4382.6 4429.2 4183.0 4236.7 4262.7 4268.5 4316.4 4293.6 4298.2 4304.1 4314.2 4353.9 4274.0 4278.0 4280.0 4314.7 4318.8 4404.8 4541.4 4560.7 4610.6 4616.2 4956.1 4966.5 4982.5 5005.9 5027.0 4898.1 4976.3 4978.3 4982.2 4983.3 4608.5 4627.8 4629.1 4681.6 4687.3 5013.8 5036.7 5036.8 5043.6 5082.4 4662.1 4809.6 4836.3 4837.3 4888.1 4941.7 4978.3 4978.7 5009.5 5015.9 4889.8 4896.8 4897.1 4902.9 4933.5 4762.5 4852.9 4877.9 4939.7 4952.5 4220.5 4226.1 4230.1 4255.1 4266.6 3665.2 3681.4 3695.8 3721.0 3736.7 4159.5 4233.2 4264.9 4279.4 4322.5 4945.7 4972.8 4975.1 5002.5 5010.2 4244.2 4245.8 4250.0 4289.6 4294.2 4380.5 4382.9 4428.8 4446.6 4449.9 4665.6 4680.4 4692.6 4710.0 4735.2 4954.4 4954.7 4961.9 4966.3 5022.4 4551.6 4689.3 4692.5 4761.6 4778.5 4833.5 4838.0 4843.0 4848.4 4896.1 4875.0 4900.1 4903.1 4907.7 4950.1 4672.1 4797.5 4816.0 4862.5 4865.3 4816.0 4834.6 4836.1 4838.7 4882.1 4591.2 4742.4 4744.3 4750.5 4792.5 4823.2 4864.2 4879.6 4907.0 4918.0 4694.5 4718.4 4722.8 4735.9 4771.3 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#1] ext.html Cycles:180 Average:44105.35 Median:18818.76 stddev:78657.13 (418.0%) stddev-sans-first:78809.95 10:24:14 INFO - PROCESS | 12681 | Values: 595.6 605.0 614.4 621.4 635.5 33130.5 34510.7 34573.1 34625.5 34656.0 35991.6 36726.3 36753.6 36794.6 36808.6 7285.2 7540.9 7659.5 7681.3 9603.1 9736.0 9886.3 9910.0 9921.0 9930.2 9840.2 10038.7 10047.1 10053.9 10055.5 7215.5 9540.7 9787.5 9787.9 9867.0 9424.9 9557.6 9558.9 9567.8 9570.2 34086.3 34855.7 34943.3 34957.1 34959.3 3075.1 3082.0 3099.9 3289.2 3339.3 26455.9 28639.1 28855.3 29353.6 29418.1 3309.1 3381.4 3384.3 3402.3 3417.5 242094.0 246236.0 246553.0 246960.0 247611.0 53874.5 54668.7 54768.0 54793.5 54800.5 49382.3 49969.8 50267.7 50283.0 50337.2 14512.1 14638.9 14728.8 14729.9 14750.8 9821.6 10668.9 10862.5 10949.1 10966.5 18015.8 18177.2 18699.2 18853.4 18908.8 6683.7 6779.5 6781.5 7029.5 7115.7 888.1 922.0 929.6 946.1 992.7 27798.3 28410.3 28512.6 28752.7 28970.3 986.4 1003.2 1027.6 1055.8 1144.3 14772.2 14885.3 15302.9 15448.3 15586.3 387052.0 394312.0 394646.3 394658.0 395133.0 48879.3 49641.3 49725.8 49733.0 49880.0 1153.6 1181.6 1214.6 1229.2 1254.1 24655.3 25749.0 25911.7 26059.5 26070.3 35287.0 35365.3 35663.8 35677.5 35755.5 228346.0 230169.0 230451.0 230529.0 230616.0 21071.7 23172.8 23520.6 23545.3 25527.9 35655.5 35772.8 35868.0 36637.1 36854.4 32004.4 34155.3 34429.0 35153.3 35427.5 33399.3 33589.8 33815.7 33979.7 34337.3 33702.3 34220.0 34392.1 34425.3 34451.8 30968.2 31032.0 31206.2 31354.3 31476.5 24272.4 24362.5 24780.8 24836.5 24944.0 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#2] jquery.html Cycles:180 Average:23917.80 Median:27975.86 stddev:64784.27 (231.6%) stddev-sans-first:64941.88 10:24:14 INFO - PROCESS | 12681 | Values: 374.2 380.8 383.7 386.8 388.3 15892.7 16533.5 17433.5 17443.8 17459.7 15924.9 16428.7 16732.7 16740.7 16768.7 3475.9 4543.1 4760.3 4761.0 4765.8 3609.8 5134.2 5481.4 5485.2 5493.6 5466.8 5466.8 5478.7 5480.3 5755.1 5896.1 6029.6 6051.8 6060.6 6061.9 3407.4 3574.5 3579.8 3585.7 5028.8 11975.9 12240.9 12329.7 12338.6 12716.9 1913.3 2007.4 2064.3 2177.9 2320.8 8777.8 9042.6 9157.6 9373.7 9523.1 1691.9 1734.7 1770.2 1778.3 1800.6 65255.3 71055.6 72151.6 72927.0 73074.0 9857.4 10120.2 10153.0 10195.5 10307.3 14234.7 14274.0 14333.5 14361.9 14374.4 6953.3 7122.9 7169.6 7233.0 7249.1 6729.9 6786.0 6860.5 6894.9 6918.8 4256.5 4277.3 4291.9 4334.4 4471.8 1707.2 1794.5 1822.6 1851.1 1858.3 793.5 840.1 900.5 923.4 941.8 15511.9 16243.0 16640.9 16733.3 17172.6 924.9 927.4 930.7 965.9 971.0 9195.0 9199.3 9475.8 9497.2 9618.8 380178.0 391739.0 394669.0 395533.0 396680.0 73489.0 75895.6 79230.9 81044.0 82144.0 907.5 910.5 918.5 933.0 935.8 14665.9 14742.1 14831.9 14924.3 14987.7 33389.0 33875.0 34444.3 34752.0 35415.1 47248.8 48620.5 49601.8 49958.8 50817.5 7747.9 7789.4 7803.5 7819.4 7856.6 10117.3 10716.3 11073.7 11143.6 11219.6 9251.7 9392.7 9481.3 9664.5 9688.6 9602.6 9676.8 9699.1 9739.6 9793.0 9395.2 9466.6 9486.4 9513.4 10007.4 7625.2 7659.5 7739.6 7827.4 7931.4 8255.8 9177.8 9325.1 9362.1 9562.9 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#3] mootools.html Cycles:180 Average:5203.15 Median:5451.01 stddev:2881.09 (52.9%) stddev-sans-first:2874.22 10:24:14 INFO - PROCESS | 12681 | Values: 1297.2 1449.1 1470.0 1557.2 1742.0 6709.8 7488.7 7734.0 7759.3 7761.8 7523.9 7700.3 7715.4 7717.4 7720.2 1850.4 1899.4 1904.4 2224.1 2261.4 2184.3 2260.8 2262.4 2263.0 2264.5 2200.8 2208.0 2216.0 2217.6 2259.8 1922.8 2159.5 2203.7 2214.8 2215.4 2221.3 2234.8 2242.9 2244.0 2244.8 7543.3 7583.9 7601.7 7608.2 7612.5 4436.6 4588.0 4611.9 4617.0 4618.3 2854.1 2984.7 3003.2 3016.4 3030.3 914.8 943.0 948.0 984.1 993.8 10820.4 10820.9 10854.3 10861.9 10881.1 4250.4 4334.7 4378.1 4412.1 4418.4 9145.5 9148.1 9157.2 9160.7 9171.4 4718.4 4729.3 4734.1 4736.7 4743.5 3746.7 4115.1 4254.5 4262.2 4343.6 3667.9 3693.8 3751.8 3763.3 3822.2 1220.1 1227.2 1230.4 1236.7 1242.4 871.5 872.7 874.6 897.2 902.5 5342.8 5349.4 5401.3 5529.8 5639.0 873.6 904.2 918.5 926.9 928.6 3675.0 3693.5 3700.7 3761.7 3768.7 9431.5 9782.3 9857.3 9864.6 9963.8 9691.9 9695.7 9756.0 9836.0 9863.3 6933.5 7086.9 7268.1 7320.9 7323.5 5343.1 5377.9 5437.4 5464.6 5520.4 8627.2 8825.8 8909.2 8928.2 8957.3 8619.0 8930.7 9038.3 9055.4 9210.2 6835.7 6857.3 6958.0 7166.9 7169.1 7408.7 7433.1 7461.7 7476.9 7502.7 6890.1 7066.9 7113.3 7113.3 7231.3 6883.3 6891.2 6933.1 6962.7 6981.0 6395.7 6412.3 6420.3 6447.0 6450.8 4735.1 4740.3 4753.6 4854.5 4919.8 4689.7 4779.5 4853.6 4864.3 4886.0 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#4] prototype.html Cycles:180 Average:4296.55 Median:4777.24 stddev:1239.30 (25.9%) stddev-sans-first:1205.80 10:24:14 INFO - PROCESS | 12681 | Values: 293.3 308.2 310.1 312.4 314.4 4630.5 4679.6 4739.0 4764.0 4809.8 4600.2 4752.3 4790.4 4794.2 4800.9 3808.9 3815.4 3824.9 3841.0 3893.4 3591.8 3669.2 3807.2 3810.6 3848.2 3771.2 3779.4 3841.8 3844.3 3844.3 3777.8 3787.3 3791.2 3793.6 3813.4 3398.4 3402.4 3410.7 3426.8 3436.8 4420.5 4539.8 4569.3 4590.8 4591.9 4325.4 4335.3 4346.8 4353.4 4388.0 4987.7 4989.5 4993.5 5004.9 5008.1 3624.1 3694.2 3714.1 3718.6 3741.0 5142.1 5200.7 5227.9 5237.4 5249.4 3787.6 3816.1 3825.1 3826.6 3834.9 3607.5 3856.6 3886.5 3889.9 3913.4 4284.9 4300.5 4331.3 4349.3 4363.4 5007.2 5014.2 5015.5 5038.0 5063.5 1310.7 1360.6 1364.7 1409.2 1410.4 959.2 965.8 975.4 977.7 986.5 4626.9 4650.3 4651.8 4654.3 4672.4 5416.7 5439.6 5442.3 5480.8 5481.3 4253.9 4621.3 4622.7 4636.0 4644.7 2936.0 2951.5 2957.7 2962.7 2984.5 5225.1 5235.9 5255.3 5263.2 5268.8 5459.2 5686.9 5702.7 5704.5 5720.1 5193.7 5230.9 5231.7 5234.8 5247.9 5549.5 5554.4 5557.6 5570.2 5577.9 5316.7 5418.8 5464.4 5481.0 5500.4 5235.0 5244.2 5245.1 5267.6 5277.3 3863.4 3869.5 3878.6 3879.4 3899.4 4906.0 5354.5 5502.3 5545.8 5547.2 4838.7 5020.6 5024.8 5029.3 5038.8 4991.5 5013.4 5018.8 5031.8 5037.8 4831.2 4925.1 4925.4 4935.5 4971.0 5009.3 5018.2 5030.7 5045.3 5064.7 4913.4 4932.3 4933.5 4938.5 4948.8 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - PROCESS | 12681 | [#5] yui.html Cycles:180 Average:13068.11 Median:24249.66 stddev:15784.16 (65.1%) stddev-sans-first:15800.71 10:24:14 INFO - PROCESS | 12681 | Values: 608.7 638.4 659.7 697.1 740.6 10804.8 10984.7 10998.8 11132.1 11158.6 11833.7 11921.9 11937.0 12437.3 12943.2 802.7 803.2 805.5 809.3 812.3 635.3 756.8 782.3 783.7 805.3 828.2 833.0 836.4 836.5 836.7 821.1 825.3 825.9 826.7 829.5 491.3 593.3 605.1 609.8 610.2 11633.7 11703.9 11737.6 11750.2 11758.4 10849.8 11200.9 11351.8 11367.5 11544.9 9622.9 9669.3 9670.8 9840.3 9940.4 3136.2 3147.2 3152.4 3155.9 3196.4 44799.8 45392.8 45525.8 45857.3 46561.3 7857.9 8999.8 9011.2 9095.9 9147.2 16343.0 16516.7 16538.9 16540.3 16584.7 6433.6 6461.3 6504.4 6539.6 6591.0 3701.4 3734.5 3737.3 3760.8 3788.6 2682.9 2743.1 2743.7 2749.8 2750.3 500.8 508.1 517.6 517.8 523.3 522.6 557.4 559.1 567.5 569.5 7606.1 7686.7 7821.0 7931.6 8044.3 435.3 511.5 592.9 611.4 615.8 3673.0 3746.9 3793.2 3874.2 3905.8 57307.4 59017.0 59239.4 59301.0 59430.0 52413.5 53817.0 53906.0 54131.2 54629.0 46711.8 47001.1 47192.3 47371.0 48008.0 7162.5 7319.9 7384.8 7451.3 7704.3 27572.5 27684.7 28666.0 29057.4 29769.9 39234.8 39302.0 40274.0 40747.2 40931.0 10112.3 10415.7 10470.4 10480.4 10514.9 10210.6 10748.9 10798.6 10920.2 11511.7 10731.9 11012.4 11167.6 11319.7 11342.9 10927.8 11140.2 11207.4 11432.6 11904.2 10307.5 10884.6 11014.7 11096.6 11630.7 9454.4 9524.2 9606.9 9798.5 9838.3 9290.7 9331.6 9437.3 9547.3 9567.6 10:24:14 INFO - PROCESS | 12681 | -------- Summary: end -------- 10:24:14 INFO - PROCESS | 12681 | 10:24:14 INFO - TEST-INFO | 12681: exit 0 10:24:14 INFO - TEST-OK | dromaeo_css | took 1119289ms 10:24:14 INFO - TEST-START | kraken 10:24:14 INFO - operating with platform_type : linux_ 10:24:14 INFO - Initialising browser for kraken test... 10:24:14 INFO - TEST-INFO | started process 12858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTUNGi/profile http://localhost:53341/getInfo.html) 10:24:18 INFO - PROCESS | 12858 | __metrics Screen width/height:1600/1200 10:24:18 INFO - PROCESS | 12858 | colorDepth:24 10:24:18 INFO - PROCESS | 12858 | Browser inner width/height: 1024/697 10:24:18 INFO - PROCESS | 12858 | __metrics 10:24:19 ERROR - PROCESS | 12858 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:24:20 INFO - TEST-INFO | 12858: exit 0 10:24:20 INFO - Browser initialized. 10:24:20 INFO - Running cycle 1/1 for kraken test... 10:24:20 INFO - TEST-INFO | started process 12939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTUNGi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:32 INFO - PROCESS | 12939 | RSS: Main: 156078080 10:24:32 INFO - PROCESS | 12939 | 10:24:35 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:36 INFO - PROCESS | 12939 | RSS: Main: 211869696 10:24:36 INFO - PROCESS | 12939 | 10:24:39 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-dft) 10:24:39 INFO - PROCESS | 12939 | RSS: Main: 196194304 10:24:39 INFO - PROCESS | 12939 | 10:24:42 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-fft) 10:24:43 INFO - PROCESS | 12939 | RSS: Main: 266493952 10:24:43 INFO - PROCESS | 12939 | 10:24:45 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-oscillator) 10:24:46 INFO - PROCESS | 12939 | RSS: Main: 175484928 10:24:46 INFO - PROCESS | 12939 | 10:24:48 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:49 INFO - PROCESS | 12939 | RSS: Main: 179859456 10:24:49 INFO - PROCESS | 12939 | 10:24:52 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:52 INFO - PROCESS | 12939 | RSS: Main: 215740416 10:24:52 INFO - PROCESS | 12939 | 10:24:56 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:56 INFO - PROCESS | 12939 | RSS: Main: 216334336 10:24:56 INFO - PROCESS | 12939 | 10:24:59 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53341/tests/kraken/driver.html?testName=json-parse-financial) 10:25:00 INFO - PROCESS | 12939 | RSS: Main: 217227264 10:25:00 INFO - PROCESS | 12939 | 10:25:02 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:02 INFO - PROCESS | 12939 | RSS: Main: 204963840 10:25:02 INFO - PROCESS | 12939 | 10:25:04 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:05 INFO - PROCESS | 12939 | RSS: Main: 206245888 10:25:05 INFO - PROCESS | 12939 | 10:25:07 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:08 INFO - PROCESS | 12939 | RSS: Main: 218300416 10:25:08 INFO - PROCESS | 12939 | 10:25:10 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:11 INFO - PROCESS | 12939 | RSS: Main: 226258944 10:25:11 INFO - PROCESS | 12939 | 10:25:14 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:14 INFO - PROCESS | 12939 | RSS: Main: 221810688 10:25:14 INFO - PROCESS | 12939 | 10:25:16 INFO - PROCESS | 12939 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53341/tests/kraken/driver.html?testName=ai-astar) 10:25:17 INFO - PROCESS | 12939 | RSS: Main: 285818880 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | __start_tp_report 10:25:17 INFO - PROCESS | 12939 | _x_x_mozilla_page_load 10:25:17 INFO - PROCESS | 12939 | _x_x_mozilla_page_load_details 10:25:17 INFO - PROCESS | 12939 | |i|pagename|runs| 10:25:17 INFO - PROCESS | 12939 | |0;ai-astar;110;113;106;112;113;114;104;112;114;115 10:25:17 INFO - PROCESS | 12939 | |1;audio-beat-detection;165;131;157;198;132;157;164;133;183;137 10:25:17 INFO - PROCESS | 12939 | |2;audio-dft;161;160;161;162;161;161;161;160;160;159 10:25:17 INFO - PROCESS | 12939 | |3;audio-fft;74;73;107;108;76;77;77;119;109;74 10:25:17 INFO - PROCESS | 12939 | |4;audio-oscillator;93;94;146;93;95;94;143;94;95;147 10:25:17 INFO - PROCESS | 12939 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 10:25:17 INFO - PROCESS | 12939 | |6;imaging-darkroom;146;147;146;146;146;146;147;147;147;146 10:25:17 INFO - PROCESS | 12939 | |7;imaging-desaturate;96;96;95;96;96;95;96;96;94;94 10:25:17 INFO - PROCESS | 12939 | |8;json-parse-financial;64;63;64;64;64;63;65;91;61;62 10:25:17 INFO - PROCESS | 12939 | |9;json-stringify-tinderbox;65;65;65;65;64;65;64;71;64;64 10:25:17 INFO - PROCESS | 12939 | |10;stanford-crypto-aes;80;78;78;79;78;87;79;79;79;79 10:25:17 INFO - PROCESS | 12939 | |11;stanford-crypto-ccm;128;131;129;133;127;129;128;129;166;138 10:25:17 INFO - PROCESS | 12939 | |12;stanford-crypto-pbkdf2;172;176;182;178;174;175;178;170;171;172 10:25:17 INFO - PROCESS | 12939 | |13;stanford-crypto-sha256-iterative;73;73;71;71;71;72;71;72;71;69 10:25:17 INFO - PROCESS | 12939 | __end_tp_report 10:25:17 INFO - PROCESS | 12939 | __start_cc_report 10:25:17 INFO - PROCESS | 12939 | _x_x_mozilla_cycle_collect,1923 10:25:17 INFO - PROCESS | 12939 | __end_cc_report 10:25:17 INFO - PROCESS | 12939 | __startTimestamp1461950717002__endTimestamp 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | ------- Summary: start ------- 10:25:17 INFO - PROCESS | 12939 | Number of tests: 14 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.62 (3.2%) stddev-sans-first:3.81 10:25:17 INFO - PROCESS | 12939 | Values: 110.0 113.0 106.0 112.0 113.0 114.0 104.0 112.0 114.0 115.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:160.50 stddev:22.93 (14.3%) stddev-sans-first:24.07 10:25:17 INFO - PROCESS | 12939 | Values: 165.0 131.0 157.0 198.0 132.0 157.0 164.0 133.0 183.0 137.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 10:25:17 INFO - PROCESS | 12939 | Values: 161.0 160.0 161.0 162.0 161.0 161.0 161.0 160.0 160.0 159.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.00 stddev:18.70 (25.3%) stddev-sans-first:18.98 10:25:17 INFO - PROCESS | 12939 | Values: 74.0 73.0 107.0 108.0 76.0 77.0 77.0 119.0 109.0 74.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:24.82 (26.4%) stddev-sans-first:25.61 10:25:17 INFO - PROCESS | 12939 | Values: 93.0 94.0 146.0 93.0 95.0 94.0 143.0 94.0 95.0 147.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:25:17 INFO - PROCESS | 12939 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:25:17 INFO - PROCESS | 12939 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 10:25:17 INFO - PROCESS | 12939 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 94.0 94.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:64.00 stddev:8.82 (13.8%) stddev-sans-first:9.33 10:25:17 INFO - PROCESS | 12939 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 65.0 91.0 61.0 62.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:2.10 (3.2%) stddev-sans-first:2.22 10:25:17 INFO - PROCESS | 12939 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 64.0 71.0 64.0 64.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.67 (3.4%) stddev-sans-first:2.83 10:25:17 INFO - PROCESS | 12939 | Values: 80.0 78.0 78.0 79.0 78.0 87.0 79.0 79.0 79.0 79.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:130.00 stddev:11.76 (9.0%) stddev-sans-first:12.29 10:25:17 INFO - PROCESS | 12939 | Values: 128.0 131.0 129.0 133.0 127.0 129.0 128.0 129.0 166.0 138.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:3.77 (2.1%) stddev-sans-first:3.86 10:25:17 INFO - PROCESS | 12939 | Values: 172.0 176.0 182.0 178.0 174.0 175.0 178.0 170.0 171.0 172.0 10:25:17 INFO - PROCESS | 12939 | 10:25:17 INFO - PROCESS | 12939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.17 (1.6%) stddev-sans-first:1.09 10:25:17 INFO - PROCESS | 12939 | Values: 73.0 73.0 71.0 71.0 71.0 72.0 71.0 72.0 71.0 69.0 10:25:17 INFO - PROCESS | 12939 | -------- Summary: end -------- 10:25:17 INFO - PROCESS | 12939 | 10:25:18 INFO - TEST-INFO | 12939: exit 0 10:25:18 INFO - TEST-OK | kraken | took 63257ms 10:25:18 INFO - SUITE-END | took 1182s 10:25:18 INFO - Completed test suite (00:19:42) 10:25:18 INFO - javascript benchmark 10:25:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.778593819525, 2677.611746296786, 2677.692065412477, 2695.0567301444485, 2714.2671478700745, 4499.437570303712, 4620.491745907947, 4633.976830115849, 4636.976815115924, 4651.767411629414, 4588.197065513538, 4623.398958135438, 4636.814527418899, 4640.651951103664, 4655.7439340836245, 4255.765932873691, 4271.850485233025, 4316.2662347400865, 4321.9783901080455, 4437.622802061828, 4339.956600434002, 4368.563143685637, 4382.342648602703, 4382.561743825624, 4429.1806015887005, 4183.0, 4236.68224883135, 4262.722923009995, 4268.466441694788, 4316.438862947828, 4293.592108749695, 4298.204832106039, 4304.096139810612, 4314.201872653569, 4353.912921741579, 4274.0, 4278.0, 4280.036991676879, 4314.7411155330465, 4318.762468064255, 4404.779761011969, 4541.409616749835, 4560.657950653681, 4610.631149508032, 4616.215243408628, 4956.08312462192, 4966.478519755446, 4982.476839931827, 5005.9499405005845, 5027.044861476308, 4898.093852637274, 4976.328195693572, 4978.303037574742, 4982.227754698028, 4983.302337672729, 4608.539146085398, 4627.838025669085, 4629.1436084324505, 4681.555252251031, 4687.2500399936525, 5013.799448022039, 5036.697798132123, 5036.84889453317, 5043.5965122790085, 5082.415522214918, 4662.114198302312, 4809.591184749335, 4836.298736683231, 4837.298591704183, 4888.144574699413, 4941.65408421407, 4978.327925730053, 4978.6763860348965, 5009.474005229398, 5015.899682006412, 4889.804407823647, 4896.828610998598, 4897.094037603055, 4902.926456103161, 4933.481984391659, 4762.52374762521, 4852.927206091911, 4877.902441951142, 4939.678920870132, 4952.504749525018, 4220.514640816284, 4226.070264541796, 4230.090530535949, 4255.106427650167, 4266.573342665709, 3665.193657395369, 3681.4109742441083, 3695.8152092395812, 3720.9627903721157, 3736.7197460190596, 4159.459270294842, 4233.195692818416, 4264.936025959613, 4279.379489973936, 4322.524522302544, 4945.703257804544, 4972.776225069881, 4975.129352363322, 5002.499750024968, 5010.248462730619, 4244.151169765997, 4245.830166793356, 4249.957500424956, 4289.592488713567, 4294.162638285505, 4380.518143004267, 4382.9342559861625, 4428.844990425384, 4446.555344465528, 4449.933251001237, 4665.626749860071, 4680.4149481314835, 4692.6480513960905, 4709.9529004710885, 4735.195016847076, 4954.430240522242, 4954.653174277766, 4961.925571116509, 4966.329545511454, 5022.447530771686, 4551.5676010778925, 4689.343491911203, 4692.50728673498, 4761.619070474423, 4778.474367819467, 4833.540813622841, 4838.0, 4843.0, 4848.418189817245, 4896.11869863428, 4874.95125048745, 4900.14247506692, 4903.092927808367, 4907.730074845917, 4950.133726597759, 4672.065586882569, 4797.520247975174, 4815.975920120377, 4862.5380588844, 4865.270209468608, 4815.975920120377, 4834.5890599299455, 4836.12949669063, 4838.7338696372035, 4882.072406242803, 4591.173588753923, 4742.407199100113, 4744.3357929890535, 4750.453697824656, 4792.496787837366, 4823.2282834746275, 4864.197407427876, 4879.585235254901, 4906.975465122651, 4917.975410122926, 4694.507076756891, 4718.386609740712, 4722.834700785456, 4735.928961065518, 4771.260454629538], "value": 4553.696026782665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5890435599437, 604.9667268300242, 614.3549273263076, 621.3506885304856, 635.4693830651406, 33130.50304245435, 34510.65489345106, 34573.135671608194, 34625.48061779075, 34656.0, 35991.640083599224, 36726.26547469049, 36753.632463675356, 36794.63205367945, 36808.63191368085, 7285.162206346258, 7540.924590754104, 7659.502132361406, 7681.3470854977395, 9603.087706667855, 9735.951320243388, 9886.307958442912, 9910.0, 9920.950395248014, 9930.162919859813, 9840.212782977345, 10038.74903127424, 10047.095761381473, 10053.94973025134, 10055.547500362465, 7215.494915355954, 9540.666076687352, 9787.46168960707, 9787.90212097884, 9867.0, 9424.90575094254, 9557.61769529218, 9558.856617150748, 9567.760805979837, 9570.186534144606, 34086.318273634635, 34855.651443485745, 34943.30113397743, 34957.12607184815, 34959.30081398358, 3075.138961090876, 3082.0, 3099.891503797356, 3289.161263877696, 3339.2653616204398, 26455.867720661467, 28639.14082577526, 28855.278618034507, 29353.559696604567, 29418.11745647634, 3309.1396236978317, 3381.3744457275484, 3384.2554637979606, 3402.302527981758, 3417.5215469834243, 242094.0, 246235.9999999982, 246553.0, 246960.0, 247611.0, 53874.46125538773, 54668.72665636647, 54768.0, 54793.452065478836, 54800.45199548033, 49382.25926611104, 49969.75015124974, 50267.74866125646, 50283.0, 50337.24494132591, 14512.1292722437, 14638.853611463748, 14728.779068313985, 14729.92635036818, 14750.778738318933, 9821.607135714634, 10668.89331106679, 10862.511186996604, 10949.124070074535, 10966.506507207196, 18015.819841801676, 18177.182026808827, 18699.158537865827, 18853.434396968114, 18908.81091189098, 6683.699233534503, 6779.49153813466, 6781.491388145811, 7029.507934444642, 7115.715371385087, 888.0852721696663, 922.0180507759216, 929.6049179098991, 946.0870260198941, 992.6873034993954, 27798.25218476904, 28410.289742756595, 28512.572311415344, 28752.712472875002, 28970.27574310659, 986.4229425785852, 1003.2325271167563, 1027.6146445083093, 1055.7993981143711, 1144.296257801446, 14772.18752968597, 14885.255737213096, 15302.923485382724, 15448.304826282843, 15586.298616562282, 387052.0, 394312.0, 394646.34798738564, 394658.0, 395133.0, 48879.26681099786, 49641.255381169314, 49725.75137124291, 49733.0, 49880.0, 1153.6135394642888, 1181.5923506390454, 1214.6173955204083, 1229.213303485752, 1254.1033161289722, 24655.260342189762, 25749.0, 25911.740882590933, 26059.478810423305, 26070.34824129336, 35287.0, 35365.29269414649, 35663.82168089143, 35677.46483802797, 35755.46366804552, 228346.0, 230169.0, 230451.0, 230529.0, 230616.0, 21071.683924741446, 23172.768272317735, 23520.647190291817, 23545.29364119079, 25527.872360638077, 35655.46516802198, 35772.821135894155, 35868.0, 36637.08407289839, 36854.44718329281, 32004.35991280115, 34155.316893662486, 34429.0, 35153.296934060665, 35427.46858797069, 33399.33201336008, 33589.83205083959, 33815.66184338224, 33979.66020339765, 34337.31325373529, 33702.3259534803, 34220.0, 34392.14019649529, 34425.31149377049, 34451.82774086113, 30968.225794355323, 31032.0, 31206.21984450407, 31354.29685547186, 31476.527852082694, 24272.393190170387, 24362.51274974526, 24780.752192477845, 24836.503269934863, 24944.0], "value": 17349.6971924454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.22161903241255, 380.7924681048828, 383.6796275110283, 386.79113278829425, 388.32625394939794, 15892.682146357067, 16533.503994880157, 17433.47699569015, 17443.825561744412, 17459.650806983853, 15924.920375398136, 16428.67142657146, 16732.66534669306, 16740.748888766677, 16768.74846877295, 3475.8957231282975, 4543.136804007237, 4760.262159365304, 4760.952390476103, 4765.761711914408, 3609.819509024538, 5134.229865520165, 5481.369642491125, 5485.232067510552, 5493.587980901429, 5466.753996070186, 5466.835994920159, 5478.671279723209, 5480.342358916935, 5755.136729490589, 5896.115582662592, 6029.577929544934, 6051.818445446644, 6060.575759696801, 6061.939380606182, 3407.4377727674905, 3574.5353104096303, 3579.8031108289033, 3585.713142948558, 5028.7988480460735, 11975.880241197563, 12240.938795306056, 12329.69175770604, 12338.629841104692, 12716.872831271661, 1913.2538310059088, 2007.4278830533228, 2064.298138632872, 2177.912883484659, 2320.8143348532076, 8777.824443511157, 9042.638294468214, 9157.587908544132, 9373.718788436357, 9523.095305945924, 1691.8815682902202, 1734.7137722275809, 1770.1680210301138, 1778.3242367900245, 1800.621869407426, 65255.347446525404, 71055.64472177658, 72151.63924180398, 72927.0, 73074.0, 9857.408555486694, 10120.190384769201, 10153.0, 10195.541200645988, 10307.278490505743, 14234.715305694035, 14274.0, 14333.498327558695, 14361.856381436051, 14374.353154107881, 6953.33943275388, 7122.893156602655, 7169.5698258104685, 7232.963835180791, 7249.093863267091, 6729.932700672931, 6786.0, 6860.451163906875, 6894.862102757917, 6918.757843475454, 4256.531781504032, 4277.2942464493635, 4291.935620965688, 4334.393184954109, 4471.8434854779925, 1707.1720215695377, 1794.452691928948, 1822.6354729054242, 1851.1118658967778, 1858.3402891973426, 793.4683761879554, 840.1304649687544, 900.4597241654955, 923.422860712055, 941.8398872191607, 15511.922440387725, 16243.0, 16640.916795416186, 16733.330666773192, 17172.570685732957, 924.9352545321763, 927.3508544019213, 930.6882194464795, 965.8599503072015, 970.9611615535299, 9195.0, 9199.310051746146, 9475.763105922408, 9497.24022078246, 9618.807623847484, 380178.0, 391739.0, 394669.0, 395533.0, 396680.0, 73489.0, 75895.62052189704, 79230.94589062371, 81044.0, 82144.0, 907.5235501361706, 910.5037754423855, 918.5040078357746, 932.9813403731887, 935.8034812689411, 14665.92667036658, 14742.11547307165, 14831.92584037073, 14924.328405221573, 14987.700245994802, 33389.0, 33875.0, 34444.31111377809, 34752.0, 35415.11462213465, 47248.76375618237, 48620.513794861596, 49601.75199123981, 49958.75020624873, 50817.49182508128, 7747.92252077472, 7789.376849851885, 7803.531788092732, 7819.41354398411, 7856.5678887661725, 10117.29178957466, 10716.303440276357, 11073.723156921142, 11143.609973650884, 11219.60731374398, 9251.67619133354, 9392.718218453458, 9481.288903332415, 9664.516774161124, 9688.5640146195, 9602.567884445356, 9676.75808104803, 9699.127078562964, 9739.610415583298, 9792.951035244778, 9395.201407880133, 9466.621335146792, 9486.383385079947, 9513.381630194015, 10007.39955602637, 7625.161232264336, 7659.463837531319, 7739.613019349123, 7827.373810095065, 7931.36549076061, 8255.752327430188, 9177.77055573616, 9325.114114159143, 9362.063793620584, 9562.904370956201], "value": 7936.992681421525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.1698113207542, 1449.0653528474131, 1470.0077447722788, 1557.1513525128803, 1741.9825801741986, 6709.832254193648, 7488.663010164542, 7733.961330193341, 7759.340456061242, 7761.844763104735, 7523.924760752391, 7700.306972372486, 7715.382769378451, 7717.421193410502, 7720.189380115091, 1850.3523766681687, 1899.4301709487167, 1904.419152158591, 2224.0992398078765, 2261.4233370490583, 2184.2682701295007, 2260.762619924909, 2262.3891549281684, 2262.988685056581, 2264.479169790949, 2200.7799220078023, 2208.039502816272, 2215.966760498594, 2217.6230040893006, 2259.807916327114, 1922.7692676878723, 2159.546495236002, 2203.724534433196, 2214.833887458431, 2215.4239897626653, 2221.3224966385246, 2234.765349638281, 2242.9102835886547, 2243.955120897573, 2244.8204143668468, 7543.283388078124, 7583.924160758377, 7601.733939312153, 7608.201138880393, 7612.467127301091, 4436.600705936449, 4587.977060114678, 4611.861644150681, 4616.976915115437, 4618.330342100377, 2854.1152242804797, 2984.686607906182, 3003.1591154476782, 3016.351484430858, 3030.272734543694, 914.826183025223, 942.9528523573863, 948.0, 984.0553069053717, 993.7913038261973, 10820.404877731722, 10820.945895270552, 10854.34873907568, 10861.891381086167, 10881.12950963921, 4250.362445633118, 4334.674899382559, 4378.058717375779, 4412.073464572476, 4418.381426600278, 9145.49699766506, 9148.085191480932, 9157.221636160868, 9160.725178244664, 9171.35800493959, 4718.433787945469, 4729.337892695025, 4734.053189362141, 4736.668433209711, 4743.501932297128, 3746.6815320698047, 4115.094679170577, 4254.532001479834, 4262.211490874198, 4343.587359200871, 3667.9266414672093, 3693.8337774800198, 3751.8311675974646, 3763.34141525232, 3822.197338558878, 1220.109320196244, 1227.2268470863478, 1230.4032544216047, 1236.6908272931767, 1242.3539759325101, 871.4945331707594, 872.6858331000834, 874.5539774714941, 897.1880448194395, 902.5036230073433, 5342.839714808562, 5349.384820745586, 5401.270828438189, 5529.834104976777, 5638.984982703071, 873.5763154869883, 904.2359206470522, 918.4764684130115, 926.9397489163183, 928.5589345061042, 3675.0, 3693.464447655129, 3700.7039436845525, 3761.6990640748672, 3768.660820526166, 9431.528423578793, 9782.266330025277, 9857.309988300893, 9864.605415783288, 9963.750906227257, 9691.903080969241, 9695.709128726008, 9755.951220243995, 9835.950820245853, 9863.260255480867, 6933.5493192942295, 7086.893696594555, 7268.127824660969, 7320.926790732131, 7323.487355885143, 5343.118385466354, 5377.865553361197, 5437.4018857926385, 5464.617476776588, 5520.447955204448, 8627.180417860292, 8825.823483530165, 8909.1536304051, 8928.15182557656, 8957.328200384867, 8619.0, 8930.687425940321, 9038.32212584072, 9055.366124371494, 9210.171084602418, 6835.69239384219, 6857.348551887562, 6957.965210173917, 7166.8924966124505, 7169.139703235645, 7408.740694075682, 7433.145188303198, 7461.701531938662, 7476.887846682413, 7502.737404190827, 6890.138732658418, 7066.929330706627, 7113.253108423748, 7113.324234197743, 7231.3130252625915, 6883.346082122191, 6891.207511136284, 6933.1333583302085, 6962.686679099554, 6981.0, 6395.744170233139, 6412.294647588668, 6420.2937676856445, 6446.967765161145, 6450.774222902176, 4735.12400205963, 4740.312654665123, 4753.619710423227, 4854.538818812207, 4919.843836698445, 4689.742064186503, 4779.498152693917, 4853.635977301646, 4864.294677271847, 4885.951140488692], "value": 4210.292697150549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3224251977932, 308.22020288669665, 310.1393632669343, 312.362779928945, 314.3979279679414, 4630.536946305368, 4679.555442232987, 4738.97630511847, 4764.023375208083, 4809.773507755522, 4600.217962946299, 4752.310914917335, 4790.449098353691, 4794.208955522335, 4800.927986080203, 3808.885733427988, 3815.3704638734644, 3824.9043773905737, 3841.0, 3893.3770596704535, 3591.8024508652015, 3669.174435751961, 3807.200487897545, 3810.618938106195, 3848.1726428817797, 3771.18919432322, 3779.4315359126067, 3841.7694938303653, 3844.3272427325105, 3844.3272427325246, 3777.7922214278206, 3787.280416720814, 3791.2227993261317, 3793.6206379361843, 3813.427985802124, 3398.4052790761516, 3402.35355282498, 3410.658934106594, 3426.777259478126, 3436.8281585920604, 4420.46954365475, 4539.795709193094, 4569.286517555916, 4590.770461476913, 4591.931121033187, 4325.372820940977, 4335.263005289108, 4346.8043938022865, 4353.432764204884, 4387.978060109711, 4987.725675087869, 4989.476105008995, 4993.525615066563, 5004.874878128039, 5008.1486147355035, 3624.1302087499075, 3694.1688120173017, 3714.0900479382453, 3718.5909549949483, 3740.9812950935343, 5142.07442660321, 5200.6879587224885, 5227.947720522822, 5237.371515418175, 5249.4488078751565, 3787.5644300905196, 3816.1413681921345, 3825.062859599416, 3826.559945606235, 3834.8716462363655, 3607.549056367954, 3856.5950575189763, 3886.5336159661024, 3889.902752431212, 3913.4325522799036, 4284.8500302489265, 4300.526942036374, 4331.28914078937, 4349.3041113421705, 4363.38912552243, 5007.198848184273, 5014.247862820606, 5015.498450154955, 5038.0, 5063.544281014652, 1310.7444048410468, 1360.59182245326, 1364.6929440875724, 1409.2390109341045, 1410.4076287959083, 959.1799011844772, 965.8309795785709, 975.4342481360794, 977.7213494154132, 986.5166068626465, 4626.86119416418, 4650.279396623271, 4651.767411629405, 4654.325122857167, 4672.369230153954, 5416.702081385482, 5439.564834813205, 5442.292501974718, 5480.80817171405, 5481.342238931354, 4253.872723728215, 4621.313220674429, 4622.699524530894, 4635.976820115878, 4644.651651126179, 2935.9853200734287, 2951.4982452983045, 2957.6746557878614, 2962.688917663614, 2984.4627966965722, 5225.1378522543355, 5235.921461178085, 5255.290535777697, 5263.210518422267, 5268.762905669254, 5459.235707001023, 5686.943130568724, 5702.7433765480655, 5704.515116215168, 5720.11338242573, 5193.740312984336, 5230.869228269247, 5231.686098834006, 5234.816781412632, 5247.868803279948, 5549.528290095387, 5554.416786237387, 5557.610967232255, 5570.192322113352, 5577.9442205577425, 5316.707581082923, 5418.753686652013, 5464.371597266365, 5480.972595136999, 5500.367457742411, 5234.97382513085, 5244.213367994831, 5245.108331583716, 5267.551423358607, 5277.2875661785165, 3863.4011728182177, 3869.5163104611925, 3878.631530004645, 3879.3792993120965, 3899.434581985653, 4906.0, 5354.54486368663, 5502.339719233718, 5545.805896793593, 5547.1679248113105, 4838.709677419366, 5020.598352131894, 5024.84925452237, 5029.295898574275, 5038.773255203451, 4991.5008499151245, 5013.448520662797, 5018.774155162953, 5031.84904452867, 5037.848864534069, 4831.154547954165, 4925.1381008324115, 4925.38432695913, 4935.531124543163, 4970.975145124396, 5009.323741294878, 5018.247262910592, 5030.748462576783, 5045.344105266438, 5064.696118232918, 4913.385826771653, 4932.28481870134, 4933.457319694902, 4938.506149385033, 4948.802047918043], "value": 3912.5859947663894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.7291155435831, 638.4445532386821, 659.6833519910446, 697.1355519156248, 740.6074780366407, 10804.783904321908, 10984.670459886196, 10998.835017474725, 11132.053775429098, 11158.553657853687, 11833.704157396069, 11921.940390298036, 11937.045036397089, 12437.315947622878, 12943.223406595587, 802.7471346525825, 803.1606970715616, 805.532790981231, 809.3039985612369, 812.273015650992, 635.2853040329629, 756.8372799848031, 782.2529484342467, 783.7335305995961, 805.3315747929234, 828.2462958707578, 833.0295206084904, 836.4103307168432, 836.506461187899, 836.6946064686376, 821.0721884270765, 825.2531459029587, 825.8678611422143, 826.7230477789948, 829.5478963964594, 491.31461611052384, 593.3413910559276, 605.0742364182807, 609.7500024989778, 610.1518888744648, 11633.70915727105, 11703.882961170364, 11737.647870563811, 11750.177487575873, 11758.353290569015, 10849.837252441219, 11200.887991120066, 11351.772964540745, 11367.488463019185, 11544.942275288653, 9622.903770962272, 9669.274804389628, 9670.75823104421, 9840.311178217527, 9940.353876997971, 3136.168915237464, 3147.2289289124083, 3152.448321543721, 3155.9053228403186, 3196.4406228909847, 44799.77600112011, 45392.77303613461, 45525.772371138264, 45857.312140317925, 46561.30158047632, 7857.882131768028, 8999.77500562478, 9011.188992990663, 9095.863562046574, 9147.176754092163, 16343.019418834909, 16516.669666606602, 16538.917305413637, 16540.338386464406, 16584.66830663404, 6433.613983161025, 6461.256955450183, 6504.38208370204, 6539.607623542603, 6591.0, 3701.3522633539023, 3734.477173195755, 3737.3085979093953, 3760.8495660173285, 3788.6400791924725, 2682.8524431156475, 2743.1359121876544, 2743.670759508832, 2749.8075134740775, 2750.339918419605, 500.78215976050535, 508.1437777345185, 517.567830861235, 517.818763432803, 523.2883278740909, 522.5662699959025, 557.3562535271686, 559.0775220885571, 567.4637467593085, 569.521601854436, 7606.125295590967, 7686.654100565488, 7821.0, 7931.5637639930355, 8044.316233120133, 435.31437985172846, 511.52172718508314, 592.9169916211733, 611.3733423241214, 615.7875532941129, 3673.0, 3746.9437958430644, 3793.2223894101644, 3874.2057878134915, 3905.8437662493184, 57307.426925731044, 59017.0, 59239.40760592425, 59301.0, 59430.0, 52413.47586524162, 53817.0, 53906.0, 54131.18803217955, 54629.0, 46711.766441168256, 47001.05997880023, 47192.29211561829, 47371.0, 48008.0, 7162.46281528877, 7319.926800732138, 7384.778456646309, 7451.2921272479025, 7704.26809453101, 27572.483513406954, 27684.723152768216, 28666.0, 29057.41885162327, 29769.851150744107, 39234.803825980685, 39302.0, 40274.0, 40747.1850562993, 40931.0, 10112.292139550162, 10415.68752937413, 10470.424126673106, 10480.42357670305, 10514.894851051391, 10210.642627508001, 10748.946255268673, 10798.568057277935, 10920.180986426209, 11511.712207194887, 10731.946340268249, 11012.449377531251, 11167.553297867995, 11319.660410187707, 11342.886571134182, 10927.781444371227, 11140.220184587, 11207.43962801873, 11432.599859005228, 11904.226225295328, 10307.536160872629, 10884.61903833362, 11014.669559913216, 11096.5561377544, 11630.709232268922, 9454.432734035705, 9524.238060955246, 9606.855897161407, 9798.51007449639, 9838.26213034011, 9290.674826381044, 9331.626734930798, 9437.346889084374, 9547.33168678186, 9567.569459374206], "value": 5815.569807421502, "unit": "score"}], "name": "dromaeo_css", "value": 6258.275192459253, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 106.0, 112.0, 113.0, 114.0, 104.0, 112.0, 114.0, 115.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 157.0, 198.0, 132.0, 157.0, 164.0, 133.0, 183.0, 137.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 107.0, 108.0, 76.0, 77.0, 77.0, 119.0, 109.0, 74.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 146.0, 93.0, 95.0, 94.0, 143.0, 94.0, 95.0, 147.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 65.0, 91.0, 61.0, 62.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 71.0, 64.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 78.0, 87.0, 79.0, 79.0, 79.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 129.0, 133.0, 127.0, 129.0, 128.0, 129.0, 166.0, 138.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 182.0, 178.0, 174.0, 175.0, 178.0, 170.0, 171.0, 172.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 71.0, 71.0, 71.0, 72.0, 71.0, 72.0, 71.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1575.8999999999999, "alertThreshold": 2.0}]} 10:25:18 INFO - Return code: 0 10:25:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:18 ERROR - # TBPL SUCCESS # 10:25:18 INFO - Running post-action listener: _resource_record_post_action 10:25:18 INFO - Running post-run listener: _resource_record_post_run 10:25:19 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 45056; Write bytes: 519315456; Read time: 60; Write time: 366964 10:25:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234790912; Read time: 0; Write time: 189460 10:25:19 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 45056; Write bytes: 284524544; Read time: 60; Write time: 177504 10:25:19 INFO - Running post-run listener: _upload_blobber_files 10:25:19 INFO - Blob upload gear active. 10:25:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:20 INFO - (blobuploader) - INFO - Done attempting. 10:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:21 INFO - (blobuploader) - INFO - Done attempting. 10:25:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:21 INFO - Return code: 0 10:25:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b258bdcabb64409c2a728d0b2f7078de3558264d306511bfb7c8b0edcc6a13e9325c284cdc7cee622b9112d52dd8d331c7192aaa79bae4ae9b55478523a46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b5ef6c5387af38fa131cca9f04523fcde6c64466d38c93c1334fcd75d5d737b96de7781b2b87e945583efb6af5eb6fed35885a7466f0c945263239f6e0a04d7"} 10:25:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:21 INFO - Contents: 10:25:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b258bdcabb64409c2a728d0b2f7078de3558264d306511bfb7c8b0edcc6a13e9325c284cdc7cee622b9112d52dd8d331c7192aaa79bae4ae9b55478523a46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b5ef6c5387af38fa131cca9f04523fcde6c64466d38c93c1334fcd75d5d737b96de7781b2b87e945583efb6af5eb6fed35885a7466f0c945263239f6e0a04d7"} 10:25:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:21 INFO - Copying logs to upload dir... 10:25:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.022194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 10:25:21.583710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:25:21.587496) ========= 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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 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/e80b258bdcabb64409c2a728d0b2f7078de3558264d306511bfb7c8b0edcc6a13e9325c284cdc7cee622b9112d52dd8d331c7192aaa79bae4ae9b55478523a46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b5ef6c5387af38fa131cca9f04523fcde6c64466d38c93c1334fcd75d5d737b96de7781b2b87e945583efb6af5eb6fed35885a7466f0c945263239f6e0a04d7"} build_url:https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/L7neUYRYRAm_wYqIMg7NqA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b258bdcabb64409c2a728d0b2f7078de3558264d306511bfb7c8b0edcc6a13e9325c284cdc7cee622b9112d52dd8d331c7192aaa79bae4ae9b55478523a46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b5ef6c5387af38fa131cca9f04523fcde6c64466d38c93c1334fcd75d5d737b96de7781b2b87e945583efb6af5eb6fed35885a7466f0c945263239f6e0a04d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:25:21.614702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:25:21.615055) ========= 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=00204705a9daa57ed339a427000001b9-1461948829.892863-1474114173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:25:21.759542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:25:21.759888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:25:21.760226) ========= ========= Total master_lag: 0.24 =========