builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1461242535.96 results: success (0) buildid: 20160421052308 builduid: f5f51b766ae14f9c864c3b7b0f8042a9 revision: a850056f05279162055f782757d4577df9ca8b85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:15.960926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:15.961386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:15.961687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:15.979470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:15.979824) ========= 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-1461241702.405957-677972523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 05:42:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-21 05:42:16 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.126340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.126665) ========= 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-1461241702.405957-677972523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017374 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.183665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.184024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a850056f05279162055f782757d4577df9ca8b85 --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 a850056f05279162055f782757d4577df9ca8b85 --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-1461241702.405957-677972523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 05:42:16,518 truncating revision to first 12 chars 2016-04-21 05:42:16,518 Setting DEBUG logging. 2016-04-21 05:42:16,518 attempt 1/10 2016-04-21 05:42:16,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a850056f0527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 05:42:16,767 unpacking tar archive at: fx-team-a850056f0527/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.732833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.733161) ========= script_repo_revision: a850056f05279162055f782757d4577df9ca8b85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.733555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.733824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:42:16.742441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-04-21 05:42:16.742723) ========= /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-1461241702.405957-677972523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:17 INFO - MultiFileLogger online at 20160421 05:42:17 in /builds/slave/test 05:42:17 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 05:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:17 INFO - {'append_to_log': False, 05:42:17 INFO - 'base_work_dir': '/builds/slave/test', 05:42:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:17 INFO - 'branch': 'Fx-Team-Non-PGO', 05:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:17 INFO - 'config_files': ('talos/linux_config.py',), 05:42:17 INFO - 'default_actions': ('clobber', 05:42:17 INFO - 'read-buildbot-config', 05:42:17 INFO - 'download-and-extract', 05:42:17 INFO - 'populate-webroot', 05:42:17 INFO - 'create-virtualenv', 05:42:17 INFO - 'install', 05:42:17 INFO - 'run-tests'), 05:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:17 INFO - 'download_minidump_stackwalk': True, 05:42:17 INFO - 'download_symbols': 'ondemand', 05:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:17 INFO - 'installer_path': 'installer.exe', 05:42:17 INFO - 'log_level': 'info', 05:42:17 INFO - 'log_name': 'talos', 05:42:17 INFO - 'log_to_console': True, 05:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:17 INFO - 'opt_config_files': (), 05:42:17 INFO - 'pip_index': False, 05:42:17 INFO - 'sps_profile': False, 05:42:17 INFO - 'sps_profile_interval': 0, 05:42:17 INFO - 'suite': 'dromaeojs', 05:42:17 INFO - 'system_bits': '32', 05:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:17 INFO - 'title': 'talos-linux64-ix-016', 05:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:17 INFO - 'use_talos_json': True, 05:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:17 INFO - 'work_dir': 'build'} 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running clobber step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: clobber 05:42:17 INFO - rmtree: /builds/slave/test/build 05:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running read-buildbot-config step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: read_buildbot_config 05:42:17 INFO - Using buildbot properties: 05:42:17 INFO - { 05:42:17 INFO - "project": "", 05:42:17 INFO - "product": "firefox", 05:42:17 INFO - "script_repo_revision": "production", 05:42:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:42:17 INFO - "repository": "", 05:42:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:42:17 INFO - "buildid": "20160421052308", 05:42:17 INFO - "pgo_build": "False", 05:42:17 INFO - "basedir": "/builds/slave/test", 05:42:17 INFO - "buildnumber": 1578, 05:42:17 INFO - "slavename": "talos-linux64-ix-016", 05:42:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:42:17 INFO - "platform": "ubuntu64_hw", 05:42:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:42:17 INFO - "branch": "fx-team", 05:42:17 INFO - "repo_path": "integration/fx-team", 05:42:17 INFO - "revision": "a850056f05279162055f782757d4577df9ca8b85", 05:42:17 INFO - "stage_platform": "linux64", 05:42:17 INFO - "builduid": "f5f51b766ae14f9c864c3b7b0f8042a9", 05:42:17 INFO - "slavebuilddir": "test" 05:42:17 INFO - } 05:42:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running download-and-extract step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: download_and_extract 05:42:17 INFO - mkdir: /builds/slave/test/build/tests 05:42:17 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')]} 05:42:17 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:42:25 INFO - Downloaded 1361 bytes. 05:42:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:25 INFO - Using the following test package requirements: 05:42:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:42:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'jsshell-linux-x86_64.zip'], 05:42:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42:25 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')]} 05:42:25 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:42:31 INFO - Downloaded 22275943 bytes. 05:42:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:42:32 INFO - Return code: 0 05:42:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:42:32 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')]} 05:42:32 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:42:34 INFO - Downloaded 22275943 bytes. 05:42:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:42:35 INFO - Return code: 0 05:42:35 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')]} 05:42:35 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:42:36 INFO - Downloaded 10845952 bytes. 05:42:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:42:37 INFO - Return code: 0 05:42:37 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')]} 05:42:37 INFO - https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:42:41 INFO - Downloaded 54669050 bytes. 05:42:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:41 INFO - mkdir: /builds/slave/test/properties 05:42:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:42:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:42:41 INFO - Contents: 05:42:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:42 INFO - Running post-action listener: _resource_record_post_action 05:42:42 INFO - Running post-action listener: set_extra_try_arguments 05:42:42 INFO - ##### 05:42:42 INFO - ##### Running populate-webroot step. 05:42:42 INFO - ##### 05:42:42 INFO - Running pre-action listener: _resource_record_pre_action 05:42:42 INFO - Running main action method: populate_webroot 05:42:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:42 INFO - '--tppagecycles', 05:42:42 INFO - '7'], 05:42:42 INFO - 'tests': ['tsvgm']}}, 05:42:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:42:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:42:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:42:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['damp', 'tps']}, 05:42:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'tests': ['damp', 'tps']}, 05:42:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['dromaeo_dom']}, 05:42:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['a11yr', 05:42:42 INFO - 'ts_paint', 05:42:42 INFO - 'tpaint', 05:42:42 INFO - 'sessionrestore', 05:42:42 INFO - 'sessionrestore_no_auto_restore', 05:42:42 INFO - 'tabpaint']}, 05:42:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['tsvgx', 05:42:42 INFO - 'tsvgr_opacity', 05:42:42 INFO - 'tart', 05:42:42 INFO - 'tscrollx', 05:42:42 INFO - 'cart']}, 05:42:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:42:42 INFO - 'tsvgr_opacity', 05:42:42 INFO - 'tart', 05:42:42 INFO - 'tscrollx', 05:42:42 INFO - 'cart']}, 05:42:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'talos_options': ['--disable-e10s'], 05:42:42 INFO - 'tests': ['tp5o']}, 05:42:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'tests': ['tp5o']}, 05:42:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'talos_options': ['--disable-e10s', 05:42:42 INFO - '--xperf_path', 05:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:42 INFO - 'tests': ['tp5n']}, 05:42:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:42 INFO - 'talos_options': ['--xperf_path', 05:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:42 INFO - 'tests': ['tp5n']}}, 05:42:42 INFO - 'talos.zip': {'path': '', 05:42:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:42 INFO - Running post-action listener: _resource_record_post_action 05:42:42 INFO - ##### 05:42:42 INFO - ##### Running create-virtualenv step. 05:42:42 INFO - ##### 05:42:42 INFO - Running pre-action listener: _resource_record_pre_action 05:42:42 INFO - Running main action method: create_virtualenv 05:42:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:42:42 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 05:42:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:42:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:42 INFO - Using real prefix '/usr' 05:42:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:42:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:44 INFO - Installing pip.................done. 05:42:44 INFO - Return code: 0 05:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:44 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 05:42:44 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 05:42:44 INFO - Using env: {'DISPLAY': ':0', 05:42:44 INFO - 'HOME': '/home/cltbld', 05:42:44 INFO - 'LANG': 'en_US.UTF-8', 05:42:44 INFO - 'LANGUAGE': 'en_US:en', 05:42:44 INFO - 'LOGNAME': 'cltbld', 05:42:44 INFO - 'MAIL': '/var/mail/cltbld', 05:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:44 INFO - 'MOZ_NO_REMOTE': '1', 05:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:44 INFO - 'NO_EM_RESTART': '1', 05:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:44 INFO - 'PWD': '/builds/slave/test', 05:42:44 INFO - 'SHELL': '/bin/bash', 05:42:44 INFO - 'SHLVL': '1', 05:42:44 INFO - 'TERM': 'linux', 05:42:44 INFO - 'TMOUT': '86400', 05:42:44 INFO - 'USER': 'cltbld', 05:42:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:44 INFO - '_': '/tools/buildbot/bin/python'} 05:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:44 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 05:42:44 INFO - Cleaning up... 05:42:44 INFO - Return code: 0 05:42:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:44 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:44 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 05:42:44 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 05:42:44 INFO - Using env: {'DISPLAY': ':0', 05:42:44 INFO - 'HOME': '/home/cltbld', 05:42:44 INFO - 'LANG': 'en_US.UTF-8', 05:42:44 INFO - 'LANGUAGE': 'en_US:en', 05:42:44 INFO - 'LOGNAME': 'cltbld', 05:42:44 INFO - 'MAIL': '/var/mail/cltbld', 05:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:44 INFO - 'MOZ_NO_REMOTE': '1', 05:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:44 INFO - 'NO_EM_RESTART': '1', 05:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:44 INFO - 'PWD': '/builds/slave/test', 05:42:44 INFO - 'SHELL': '/bin/bash', 05:42:44 INFO - 'SHLVL': '1', 05:42:44 INFO - 'TERM': 'linux', 05:42:44 INFO - 'TMOUT': '86400', 05:42:44 INFO - 'USER': 'cltbld', 05:42:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:44 INFO - '_': '/tools/buildbot/bin/python'} 05:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:45 INFO - Downloading/unpacking psutil>=0.7.1 05:42:45 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 05:42:45 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 05:42:45 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 05:42:45 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 05:42:45 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 05:42:45 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 05:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:47 INFO - Installing collected packages: psutil 05:42:47 INFO - Running setup.py install for psutil 05:42:47 INFO - building 'psutil._psutil_linux' extension 05:42:47 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 05:42:47 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 05:42:47 INFO - building 'psutil._psutil_posix' extension 05:42:47 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 05:42:47 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 05:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:47 INFO - Successfully installed psutil 05:42:47 INFO - Cleaning up... 05:42:47 INFO - Return code: 0 05:42:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:47 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:47 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 05:42:47 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 05:42:47 INFO - Using env: {'DISPLAY': ':0', 05:42:47 INFO - 'HOME': '/home/cltbld', 05:42:47 INFO - 'LANG': 'en_US.UTF-8', 05:42:47 INFO - 'LANGUAGE': 'en_US:en', 05:42:47 INFO - 'LOGNAME': 'cltbld', 05:42:47 INFO - 'MAIL': '/var/mail/cltbld', 05:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:47 INFO - 'MOZ_NO_REMOTE': '1', 05:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:47 INFO - 'NO_EM_RESTART': '1', 05:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:47 INFO - 'PWD': '/builds/slave/test', 05:42:47 INFO - 'SHELL': '/bin/bash', 05:42:47 INFO - 'SHLVL': '1', 05:42:47 INFO - 'TERM': 'linux', 05:42:47 INFO - 'TMOUT': '86400', 05:42:47 INFO - 'USER': 'cltbld', 05:42:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:47 INFO - '_': '/tools/buildbot/bin/python'} 05:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:42:47 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 05:42:47 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 05:42:47 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 05:42:47 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 05:42:47 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 05:42:47 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 05:42:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:42:49 INFO - Installing collected packages: mozsystemmonitor 05:42:49 INFO - Running setup.py install for mozsystemmonitor 05:42:49 INFO - Successfully installed mozsystemmonitor 05:42:49 INFO - Cleaning up... 05:42:49 INFO - Return code: 0 05:42:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:49 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 05:42:49 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 05:42:49 INFO - Using env: {'DISPLAY': ':0', 05:42:49 INFO - 'HOME': '/home/cltbld', 05:42:49 INFO - 'LANG': 'en_US.UTF-8', 05:42:49 INFO - 'LANGUAGE': 'en_US:en', 05:42:49 INFO - 'LOGNAME': 'cltbld', 05:42:49 INFO - 'MAIL': '/var/mail/cltbld', 05:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:49 INFO - 'MOZ_NO_REMOTE': '1', 05:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:49 INFO - 'NO_EM_RESTART': '1', 05:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:49 INFO - 'PWD': '/builds/slave/test', 05:42:49 INFO - 'SHELL': '/bin/bash', 05:42:49 INFO - 'SHLVL': '1', 05:42:49 INFO - 'TERM': 'linux', 05:42:49 INFO - 'TMOUT': '86400', 05:42:49 INFO - 'USER': 'cltbld', 05:42:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:49 INFO - '_': '/tools/buildbot/bin/python'} 05:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:50 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 05:42:50 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 05:42:50 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 05:42:50 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 05:42:50 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 05:42:50 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 05:42:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 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 05:42:52 INFO - Downloading docopt-0.6.1.tar.gz 05:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:52 INFO - Running setup.py install for blobuploader 05:42:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:52 INFO - Running setup.py install for requests 05:42:53 INFO - Running setup.py install for docopt 05:42:53 INFO - Successfully installed blobuploader requests docopt 05:42:53 INFO - Cleaning up... 05:42:53 INFO - Return code: 0 05:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:53 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:53 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 05:42:53 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 05:42:53 INFO - Using env: {'DISPLAY': ':0', 05:42:53 INFO - 'HOME': '/home/cltbld', 05:42:53 INFO - 'LANG': 'en_US.UTF-8', 05:42:53 INFO - 'LANGUAGE': 'en_US:en', 05:42:53 INFO - 'LOGNAME': 'cltbld', 05:42:53 INFO - 'MAIL': '/var/mail/cltbld', 05:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:53 INFO - 'MOZ_NO_REMOTE': '1', 05:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:53 INFO - 'NO_EM_RESTART': '1', 05:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:53 INFO - 'PWD': '/builds/slave/test', 05:42:53 INFO - 'SHELL': '/bin/bash', 05:42:53 INFO - 'SHLVL': '1', 05:42:53 INFO - 'TERM': 'linux', 05:42:53 INFO - 'TMOUT': '86400', 05:42:53 INFO - 'USER': 'cltbld', 05:42:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:53 INFO - '_': '/tools/buildbot/bin/python'} 05:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:53 INFO - Running setup.py (path:/tmp/pip-Q5FfY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:53 INFO - Running setup.py (path:/tmp/pip-Sy2l0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:53 INFO - Running setup.py (path:/tmp/pip-9pN0En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:53 INFO - Running setup.py (path:/tmp/pip-KJ8KvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:53 INFO - Running setup.py (path:/tmp/pip-gAqTLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:53 INFO - Running setup.py (path:/tmp/pip-TjO3vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:54 INFO - Running setup.py (path:/tmp/pip-7rj8yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:54 INFO - Running setup.py (path:/tmp/pip-eCgNxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:54 INFO - Running setup.py (path:/tmp/pip-2I_lyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:54 INFO - Running setup.py (path:/tmp/pip-H3f1a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:54 INFO - Running setup.py (path:/tmp/pip-4UeUv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:54 INFO - Running setup.py (path:/tmp/pip-siM6kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:54 INFO - Running setup.py (path:/tmp/pip-iKK8FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:54 INFO - Running setup.py (path:/tmp/pip-YKJzJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:54 INFO - Running setup.py (path:/tmp/pip-8JlOMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:54 INFO - Running setup.py (path:/tmp/pip-RdZD44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:54 INFO - Running setup.py (path:/tmp/pip-0K5qSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:54 INFO - Running setup.py install for manifestparser 05:42:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:54 INFO - Running setup.py install for mozcrash 05:42:55 INFO - Running setup.py install for mozdebug 05:42:55 INFO - Running setup.py install for mozdevice 05:42:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for mozfile 05:42:55 INFO - Running setup.py install for mozhttpd 05:42:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for mozinfo 05:42:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for mozInstall 05:42:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for mozleak 05:42:55 INFO - Running setup.py install for mozlog 05:42:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for moznetwork 05:42:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:55 INFO - Running setup.py install for mozprocess 05:42:56 INFO - Running setup.py install for mozprofile 05:42:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:56 INFO - Running setup.py install for mozrunner 05:42:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:56 INFO - Running setup.py install for mozscreenshot 05:42:56 INFO - Running setup.py install for moztest 05:42:56 INFO - Running setup.py install for mozversion 05:42:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:56 INFO - Cleaning up... 05:42:56 INFO - Return code: 0 05:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:56 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:42:56 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 05:42:56 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 05:42:56 INFO - Using env: {'DISPLAY': ':0', 05:42:56 INFO - 'HOME': '/home/cltbld', 05:42:56 INFO - 'LANG': 'en_US.UTF-8', 05:42:56 INFO - 'LANGUAGE': 'en_US:en', 05:42:56 INFO - 'LOGNAME': 'cltbld', 05:42:56 INFO - 'MAIL': '/var/mail/cltbld', 05:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:56 INFO - 'MOZ_NO_REMOTE': '1', 05:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:56 INFO - 'NO_EM_RESTART': '1', 05:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:56 INFO - 'PWD': '/builds/slave/test', 05:42:56 INFO - 'SHELL': '/bin/bash', 05:42:56 INFO - 'SHLVL': '1', 05:42:56 INFO - 'TERM': 'linux', 05:42:56 INFO - 'TMOUT': '86400', 05:42:56 INFO - 'USER': 'cltbld', 05:42:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:56 INFO - '_': '/tools/buildbot/bin/python'} 05:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:56 INFO - Running setup.py (path:/tmp/pip-1KvYhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:56 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)) 05:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:56 INFO - Running setup.py (path:/tmp/pip-lewA1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:56 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)) 05:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:56 INFO - Running setup.py (path:/tmp/pip-nzvW2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:57 INFO - Running setup.py (path:/tmp/pip-wyCdkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:57 INFO - Running setup.py (path:/tmp/pip-HDNQpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:57 INFO - Running setup.py (path:/tmp/pip-n0JkE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:57 INFO - Running setup.py (path:/tmp/pip-BFYlFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:57 INFO - Running setup.py (path:/tmp/pip-4DYTQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:57 INFO - Running setup.py (path:/tmp/pip-a0N0hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:57 INFO - Running setup.py (path:/tmp/pip-RE1EQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:57 INFO - Running setup.py (path:/tmp/pip-mYnKwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:57 INFO - Running setup.py (path:/tmp/pip-00iawa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:57 INFO - Running setup.py (path:/tmp/pip-C3cbZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:57 INFO - Running setup.py (path:/tmp/pip-hZnpSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:57 INFO - Running setup.py (path:/tmp/pip-n4liqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:57 INFO - Running setup.py (path:/tmp/pip-mdlHdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:57 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)) 05:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:57 INFO - Running setup.py (path:/tmp/pip-UTLnZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:58 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)) 05:42:58 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)) 05:42:58 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)) 05:42:58 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)) 05:42:58 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)) 05:42:58 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)) 05:42:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:59 INFO - Downloading blessings-1.6.tar.gz 05:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:00 INFO - Installing collected packages: blessings 05:43:00 INFO - Running setup.py install for blessings 05:43:00 INFO - Successfully installed blessings 05:43:00 INFO - Cleaning up... 05:43:00 INFO - Return code: 0 05:43:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:00 INFO - Reading from file tmpfile_stdout 05:43:00 INFO - Current package versions: 05:43:00 INFO - argparse == 1.2.1 05:43:00 INFO - blessings == 1.6 05:43:00 INFO - blobuploader == 1.2.4 05:43:00 INFO - docopt == 0.6.1 05:43:00 INFO - manifestparser == 1.1 05:43:00 INFO - mozInstall == 1.12 05:43:00 INFO - mozcrash == 0.17 05:43:00 INFO - mozdebug == 0.1 05:43:00 INFO - mozdevice == 0.48 05:43:00 INFO - mozfile == 1.2 05:43:00 INFO - mozhttpd == 0.7 05:43:00 INFO - mozinfo == 0.9 05:43:00 INFO - mozleak == 0.1 05:43:00 INFO - mozlog == 3.1 05:43:00 INFO - moznetwork == 0.27 05:43:00 INFO - mozprocess == 0.22 05:43:00 INFO - mozprofile == 0.28 05:43:00 INFO - mozrunner == 6.11 05:43:00 INFO - mozscreenshot == 0.1 05:43:00 INFO - mozsystemmonitor == 0.0 05:43:00 INFO - moztest == 0.7 05:43:00 INFO - mozversion == 1.4 05:43:00 INFO - psutil == 3.1.1 05:43:00 INFO - requests == 1.2.3 05:43:00 INFO - wsgiref == 0.1.2 05:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:00 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:43:00 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 05:43:00 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 05:43:00 INFO - Using env: {'DISPLAY': ':0', 05:43:00 INFO - 'HOME': '/home/cltbld', 05:43:00 INFO - 'LANG': 'en_US.UTF-8', 05:43:00 INFO - 'LANGUAGE': 'en_US:en', 05:43:00 INFO - 'LOGNAME': 'cltbld', 05:43:00 INFO - 'MAIL': '/var/mail/cltbld', 05:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:00 INFO - 'MOZ_NO_REMOTE': '1', 05:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:00 INFO - 'NO_EM_RESTART': '1', 05:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:00 INFO - 'PWD': '/builds/slave/test', 05:43:00 INFO - 'SHELL': '/bin/bash', 05:43:00 INFO - 'SHLVL': '1', 05:43:00 INFO - 'TERM': 'linux', 05:43:00 INFO - 'TMOUT': '86400', 05:43:00 INFO - 'USER': 'cltbld', 05:43:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:00 INFO - '_': '/tools/buildbot/bin/python'} 05:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 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)) 05:43:00 INFO - Cleaning up... 05:43:00 INFO - Return code: 0 05:43:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:00 INFO - Using env: {'DISPLAY': ':0', 05:43:00 INFO - 'HOME': '/home/cltbld', 05:43:00 INFO - 'LANG': 'en_US.UTF-8', 05:43:00 INFO - 'LANGUAGE': 'en_US:en', 05:43:00 INFO - 'LOGNAME': 'cltbld', 05:43:00 INFO - 'MAIL': '/var/mail/cltbld', 05:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:00 INFO - 'MOZ_NO_REMOTE': '1', 05:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:00 INFO - 'NO_EM_RESTART': '1', 05:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:00 INFO - 'PWD': '/builds/slave/test', 05:43:00 INFO - 'SHELL': '/bin/bash', 05:43:00 INFO - 'SHLVL': '1', 05:43:00 INFO - 'TERM': 'linux', 05:43:00 INFO - 'TMOUT': '86400', 05:43:00 INFO - 'USER': 'cltbld', 05:43:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:00 INFO - '_': '/tools/buildbot/bin/python'} 05:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:00 INFO - Downloading/unpacking jsonschema 05:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:02 INFO - warning: no files found matching '*.txt' 05:43:02 INFO - no previously-included directories found matching 'build' 05:43:02 INFO - no previously-included directories found matching 'dist' 05:43:02 INFO - no previously-included directories found matching '.git*' 05:43:02 INFO - Installing collected packages: jsonschema, functools32 05:43:03 INFO - Running setup.py install for functools32 05:43:03 INFO - warning: no files found matching '*.txt' 05:43:03 INFO - no previously-included directories found matching 'build' 05:43:03 INFO - no previously-included directories found matching 'dist' 05:43:03 INFO - no previously-included directories found matching '.git*' 05:43:03 INFO - Successfully installed jsonschema functools32 05:43:03 INFO - Cleaning up... 05:43:03 INFO - Return code: 0 05:43:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:43:03 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')]} 05:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:03 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')]} 05:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:03 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 0x7fea7c42df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, '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-1461241702.405957-677972523', '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 05:43:03 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 05:43:03 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 05:43:03 INFO - Using env: {'DISPLAY': ':0', 05:43:03 INFO - 'HOME': '/home/cltbld', 05:43:03 INFO - 'LANG': 'en_US.UTF-8', 05:43:03 INFO - 'LANGUAGE': 'en_US:en', 05:43:03 INFO - 'LOGNAME': 'cltbld', 05:43:03 INFO - 'MAIL': '/var/mail/cltbld', 05:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:03 INFO - 'MOZ_NO_REMOTE': '1', 05:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:03 INFO - 'NO_EM_RESTART': '1', 05:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:03 INFO - 'PWD': '/builds/slave/test', 05:43:03 INFO - 'SHELL': '/bin/bash', 05:43:03 INFO - 'SHLVL': '1', 05:43:03 INFO - 'TERM': 'linux', 05:43:03 INFO - 'TMOUT': '86400', 05:43:03 INFO - 'USER': 'cltbld', 05:43:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:03 INFO - '_': '/tools/buildbot/bin/python'} 05:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:03 INFO - Downloading/unpacking flake8 05:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:43:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:43:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 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 05:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:05 INFO - no previously-included directories found matching 'docs/_build' 05:43:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:43:06 INFO - Running setup.py install for pep8 05:43:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:06 INFO - no previously-included directories found matching 'docs/_build' 05:43:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:43:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:43:06 INFO - Cleaning up... 05:43:06 INFO - Return code: 0 05:43:06 INFO - Running post-action listener: _resource_record_post_action 05:43:06 INFO - Running post-action listener: _start_resource_monitoring 05:43:06 INFO - Starting resource monitoring. 05:43:06 INFO - ##### 05:43:06 INFO - ##### Running install step. 05:43:06 INFO - ##### 05:43:06 INFO - Running pre-action listener: _resource_record_pre_action 05:43:06 INFO - Running main action method: install 05:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:06 INFO - Reading from file tmpfile_stdout 05:43:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:06 INFO - Reading from file tmpfile_stdout 05:43:06 INFO - Output received: 05:43:06 INFO - Usage: mozinstall [options] installer 05:43:06 INFO - Options: 05:43:06 INFO - -h, --help show this help message and exit 05:43:06 INFO - -d DEST, --destination=DEST 05:43:06 INFO - Directory to install application into. [default: 05:43:06 INFO - "/builds/slave/test"] 05:43:06 INFO - --app=APP Application being installed. [default: firefox] 05:43:06 INFO - mkdir: /builds/slave/test/build/application 05:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:43:22 INFO - Reading from file tmpfile_stdout 05:43:22 INFO - Output received: 05:43:22 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:22 INFO - Running post-action listener: _resource_record_post_action 05:43:22 INFO - ##### 05:43:22 INFO - ##### Running run-tests step. 05:43:22 INFO - ##### 05:43:22 INFO - Running pre-action listener: _resource_record_pre_action 05:43:22 INFO - Running main action method: run_tests 05:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:22 INFO - Python 2.7.3 05:43:22 INFO - Return code: 0 05:43:22 INFO - grabbing minidump binary from tooltool 05:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:22 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 0x1388410>, '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 0x1389310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13897a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:22 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 05:43:22 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 05:43:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:22 INFO - Return code: 0 05:43:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:43:23 INFO - Return code: 0 05:43:23 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.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 05:43:23 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.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 05:43:23 INFO - Using env: {'DISPLAY': ':0', 05:43:23 INFO - 'HOME': '/home/cltbld', 05:43:23 INFO - 'LANG': 'en_US.UTF-8', 05:43:23 INFO - 'LANGUAGE': 'en_US:en', 05:43:23 INFO - 'LOGNAME': 'cltbld', 05:43:23 INFO - 'MAIL': '/var/mail/cltbld', 05:43:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:23 INFO - 'MOZ_NO_REMOTE': '1', 05:43:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:23 INFO - 'NO_EM_RESTART': '1', 05:43:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:23 INFO - 'PWD': '/builds/slave/test', 05:43:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:23 INFO - 'SHELL': '/bin/bash', 05:43:23 INFO - 'SHLVL': '1', 05:43:23 INFO - 'TERM': 'linux', 05:43:23 INFO - 'TMOUT': '86400', 05:43:23 INFO - 'USER': 'cltbld', 05:43:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461241702.405957-677972523', 05:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:23 INFO - '_': '/tools/buildbot/bin/python'} 05:43:23 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/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.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 05:43:23 INFO - mozversion application_buildid: 20160421052308 05:43:23 INFO - mozversion application_changeset: a850056f05279162055f782757d4577df9ca8b85 05:43:23 INFO - mozversion application_display_name: Nightly 05:43:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:23 INFO - mozversion application_name: Firefox 05:43:23 INFO - mozversion application_remotingname: firefox 05:43:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:43:23 INFO - mozversion application_vendor: Mozilla 05:43:23 INFO - mozversion application_version: 48.0a1 05:43:23 INFO - mozversion platform_buildid: 20160421052308 05:43:23 INFO - mozversion platform_changeset: a850056f05279162055f782757d4577df9ca8b85 05:43:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:43:23 INFO - mozversion platform_version: 48.0a1 05:43:23 INFO - using testdate: 1461242603 05:43:23 INFO - actual date: 1461242603 05:43:23 INFO - starting webserver on 'localhost:51119' 05:43:23 INFO - SUITE-START | Running 2 tests 05:43:23 INFO - TEST-START | dromaeo_css 05:43:23 INFO - operating with platform_type : linux_ 05:43:23 INFO - Initialising browser for dromaeo_css test... 05:43:23 INFO - TEST-INFO | started process 5909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXfTDMH/profile http://localhost:51119/getInfo.html) 05:43:27 INFO - PROCESS | 5909 | __metrics Screen width/height:1600/1200 05:43:27 INFO - PROCESS | 5909 | colorDepth:24 05:43:27 INFO - PROCESS | 5909 | Browser inner width/height: 1024/697 05:43:27 INFO - PROCESS | 5909 | __metrics 05:43:29 ERROR - PROCESS | 5909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:43:29 INFO - TEST-INFO | 5909: exit 0 05:43:29 INFO - Browser initialized. 05:43:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:29 INFO - TEST-INFO | started process 5991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXfTDMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:41 INFO - PROCESS | 5991 | RSS: Main: 155234304 05:43:41 INFO - PROCESS | 5991 | 05:44:32 INFO - PROCESS | 5991 | 1461242672913 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] 05:46:44 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51119/tests/dromaeo/cssquery-ext.html) 05:46:45 INFO - PROCESS | 5991 | RSS: Main: 228536320 05:46:45 INFO - PROCESS | 5991 | 05:49:47 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-ext.html (next: http://localhost:51119/tests/dromaeo/cssquery-jquery.html) 05:49:48 INFO - PROCESS | 5991 | RSS: Main: 231047168 05:49:48 INFO - PROCESS | 5991 | 05:52:50 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51119/tests/dromaeo/cssquery-mootools.html) 05:52:51 INFO - PROCESS | 5991 | RSS: Main: 230051840 05:52:51 INFO - PROCESS | 5991 | 05:55:53 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51119/tests/dromaeo/cssquery-prototype.html) 05:55:54 INFO - PROCESS | 5991 | RSS: Main: 237084672 05:55:54 INFO - PROCESS | 5991 | 05:58:56 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51119/tests/dromaeo/cssquery-yui.html) 05:58:57 INFO - PROCESS | 5991 | RSS: Main: 217616384 05:58:57 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:51119/tests/dromaeo/cssquery-yui.html (next: http://localhost:51119/tests/dromaeo/cssquery-dojo.html) 06:02:00 INFO - PROCESS | 5991 | RSS: Main: 255447040 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | __start_tp_report 06:02:00 INFO - PROCESS | 5991 | _x_x_mozilla_page_load 06:02:00 INFO - PROCESS | 5991 | _x_x_mozilla_page_load_details 06:02:00 INFO - PROCESS | 5991 | |i|pagename|runs| 06:02:00 INFO - PROCESS | 5991 | |0;dojo.html;2577.342777591714;2634.841909485431;2649.74827391398;2666.69333026702;2666.7733242674367;4568.84009059683;4619.376384188134;4630.143423466657;4638.837640682581;4654.883627909304;4624.028953919681;4671.696339737915;4676.812927482905;4706.294055891618;4713.38725965624;4255.148970205955;4256.170046840867;4292.0342922842265;4318.287482565373;4412.97793511032;4367.650587952956;4389.341598760179;4390.956090439103;4423.071155057426;4443.88890277744;4124.876253712393;4203.684723645739;4283.4431523902;4326.199653064194;4347.978260108679;4321.178975994551;4322.157179350028;4348.782560871944;4363.52001279859;4363.847265345729;4288.206681763883;4289.871303860889;4300.720453170534;4304.289792184286;4339.305711086243;4456.6880318377725;4507.842225522091;4550.362949187116;4568.931466028012;4597.724136551784;4968.900621987576;4974.900501989976;4976.825811096594;4995.250712393134;5012.473690262506;5004.324416203803;5009.924851127236;5016.799328026875;5023.196288593807;5069.543741063285;4517.096580683843;4629.375034370384;4680.602148817321;4699.95300047002;4703.6942598730975;5079.796808127633;5083.440821509631;5099.821506247264;5107.131787596118;5109.4379618241965;4896.216605343128;4915.754212289371;4916.754162291871;4917.483664215278;4935.876603084952;4845.951540484621;4880.292357608198;4924.75376231187;4966.453690094087;4978.079055374767;4929.827456039022;4965.155923493015;4978.054169707744;4988.90022199554;5033.270175824485;4806.639502037361;4938.530839570235;4945.431275403303;4948.678335908155;4988.900221995613;4096.774677392772;4120.670346372283;4120.876373708794;4159.667226621863;4160.167966406731;3650.2881938021833;3655.3420384330543;3657.3233951719017;3660.731647728148;3690.151265209017;4189.036521600049;4266.125444283976;4350.73895566267;4351.8694439166875;4383.1452866691325;4975.925361119586;5019.247112933089;5025.3718285214345;5053.292539044537;5072.315237442898;4335.978320108379;4369.60673539383;4377.693561450732;4379.386885835986;4379.671524635665;4331.436913201263;4377.299632058855;4487.528809475023;4493.88765280864;4516;4770.403699537558;4787.61699064081;4803.975980120077;4840.394950631171;4841.685290456038;5011.749412529286;5018.447970723145;5024.246363045426;5024.824131155392;5068.670536415121;4652.674312798072;4763.1426343258545;4779.928301075556;4797.009553366561;4848.951510484992;4916.0905232532095;4933.777979990838;4936.185529387611;4940.357753492023;4980.701157930535;4968.850934471971;4978.800847966041;5005.77474013663;5015.423226328873;5049.141645920129;4678.251479763221;4805.7597120143155;4860.9513904861915;4864.92702609454;4921.729304888266;4818.156822556109;4823.975880120577;4830.347903033186;4862.343583616166;4877.95122048775;4762.476127626028;4769.260764581495;4769.642276829182;4776.068666609977;4812.470628230962;4778.187708089564;4849.393825771778;4872.366592342973;4919.434265059564;4923.803047878045;4756.500567440507;4774.092922344744;4774.976125119352;4782;4831.589314908131 06:02:00 INFO - PROCESS | 5991 | |1;ext.html;565.558864086013;584.1092334190362;585.4555263604847;600.4295918877067;604.4167378479772;33828.32343353132;34968.650313496924;34978;35009;35056.298874022534;36807.4478882817;37613.62386376136;37657.246855062884;37670.8116459418;37708.24583508328;7649.961750191242;7820.726274580391;7825.9217407826045;7857.882131768028;7861.724839630614;7761.068671759397;7875.763727088168;7881.645325960346;8075.111737708848;8077.676892924276;8067.717629882955;8154.306883914875;8156.143604921487;8156.347492200639;8156.877646835303;8006.23940725633;8069.7175598853755;8076.394270429682;8082.5150490970145;8083.838323233532;7890.9605451972375;8065.516069035877;8110.553919534483;8121.95939020307;8122.918770812275;37149.628503714885;37480.81259593712;37567.81216093929;37689.623103768885;37698;3114.174743692923;3171.952420713691;3242.270489139948;3343.1474973881504;3720.9069773255887;28683.28291792701;28696;28828.42343153146;29410.558841617392;29546.556801647992;3246.107320486885;3341;3378.3074469733647;3439.793612383265;3521.8239088045493;154916;155745;156020;156105;156408.21795891062;46460;46877.29684054742;46956.5304346959;47075.293870591966;47114.29328560075;49319;56737.716311419004;58092;58555.41444585499;58562.4143758557;13920.30398480072;14143.575692729235;14155.221462819643;14166.575002749934;14168.64578385528;9714.174295184988;10335;10352.689419317432;10364.170866330676;10375.533101010322;18041.7293740594;18510.537236568925;18582.628347432976;18737.250509979447;18759.15583798705;6705.48544295889;6727.697253623599;6891.75878844238;6951.096357473496;7057.36483716468;858.8239410920746;907.6732376344511;911.5260064766417;971.1696499492832;998.1316254858319;28033.299167520567;28492.715072849005;28636.856815716204;28966;29085.127446176648;996.9631583153584;1000.6147633161286;1007.9294449388619;1077.42357838556;1135.0975974100609;15005.17471539054;15108.320125594375;15181.696366072616;15294.158821264937;15492.147931863856;346736;352932;353036;353498;353853;48194.5180548197;49443;49553.752231239334;49783.25325120126;49793.75103124534;1034.4879284754095;1152.9596464123715;1163.5752950173126;1243.682860870454;1267.043382246398;24864.12975545847;25517.23448296554;26170.476590468465;26710.19869403921;28118.578221327105;38714.612853872226;38851.61148388593;39278.21443571056;39368.80315598404;39377.80311098426;177275;177329;178174;178346;178664;21858.45353866166;25011.74988250167;25796;25823;25827.354316141496;36537.45193822148;36563;36657;36871.262574747816;37438.8128059358;32008.67991320057;32981.67018329786;34239;34745.30509389849;35150.824245878604;33953;33995.66004339925;34124.488132678525;34544.654553454144;34730.479042814884;33518;34049.82975085109;34120;34422.31155376929;34464.82767586146;29840.552391713707;30912;31207.219819504695;31329.49364050916;31358.84320578474;23980.640290396008;24430.878357234014;24469.38826529351;24550.386240344134;24575.262742117764 06:02:00 INFO - PROCESS | 5991 | |2;jquery.html;359.33881657749737;359.98560057597683;363.17921497415836;366.1359192306157;377.8658576205449;15604.921975390122;16189.514314570568;16811.495655130366;16849.241784119728;16859.494215173534;15992.280347384367;16651.417200397987;16827.41104061358;17409.91295043526;17475.563110922234;5048.7980480780725;5207.557357624588;5251.212318152269;5251.579873610102;5254.632175747699;3604;3815.084379748868;5180.585553155757;5633.0987042073275;5950.404959504058;5868.3838196989345;5873.794417195399;5903.852403689899;5913.231279933624;5919.23050003499;5734.7419366128415;5758;5892.14563888236;5896.528277737771;5899.557533185029;3285.4250506161325;4918.483559226265;5154.201098829687;5191.454897235773;5192.247124167013;18661.813381866144;19034.52413689655;19126.52183695405;20278.391648250577;20295.5940881183;1828.9634207315912;1838.347386677737;1979.8119178678003;1987.7018447232886;2020.4847763820278;12274.754504909852;12656.177348472413;12903.096783225177;12930.935345323307;13490.258035808027;1707.4024091567976;1796.6496533176037;1805.702059160237;1819.5087326421924;1824.6533158699804;62297;62859.6857015712;64112;64278.35721642771;64775.67612161956;9000.099990000948;9206.125418085272;9497.952510237405;9566.712998610054;9612.711618651452;12879.806802897963;12917.160384574972;13061.21632702022;13123.60629181107;13151.67120821968;7113.573185608777;7234.312740289769;7300.598467084362;7412.295831896069;7435.51669141504;7011.193712723;7108.537945033556;7174.713011479483;7196.0645116134565;7220.241874603196;5991.430814072656;6083.878322433527;6133.1413602095745;6160.507159427235;6227.937720622826;1582.2484319947932;1622.7971503562055;1623.699615571123;1644.1861278667136;1678.211240716861;853.6158728572043;902.8555431130987;962.41292811385;966.2656381150376;974.1524873360222;15490.845091549165;16173.353065877232;16220.35118595243;16322.347106115622;16348.34606615722;888.706726780161;903.9231665308391;924.0159230419582;947.9052094790466;957.4207604399378;7097.716091356391;9935.701928942144;9960.352577082467;9972.900270997197;10072.194224462026;383941;388571;397429;401889;403334;61820;63213.683931580046;64080.67959660265;64827.35172648307;65298.34701653018;966.6230170233614;976.72651657536;977.8191034658611;979.1823827104305;991.613270824379;14902.85097149058;14977.643444158395;15080.622984425478;15154.242287885781;15349.462768803038;29460;29854.402911941204;30569.23576910595;31295.374092517566;31473.685263147076;40623.39064914088;40738.59261407348;40817;41077.589224107374;41386.172276554906;7243.311885370881;7379.188289288067;7589.810254743676;7631.122420921665;7790.61046947639;8643.654253829776;11565.502227015839;11899.107566932342;11922.701932451759;12047;6781.559198652072;9805.656802011896;10335.553022576996;10500.159987201157;10557.472126393495;10028.498575071364;10313.896861031593;10458.26792124544;10463;10703.518341674799;10404.930545488947;10538.78922421532;10662;10691.786164276826;11284.153688473561;7238.493305468567;7566.432517561095;7658.961705191438;7702.4608277422285;7828.021497312836;8548.572571371282;9774.218062555121;9987.25095617817;10116.64591739315;10476.895231047592 06:02:00 INFO - PROCESS | 5991 | |3;mootools.html;1268.549664868972;1429.9285035748212;1430.1919415530228;1543.1435553267938;1728.0409372798092;6760.357766012227;6994.440444764419;7567.583782891938;7779.572123533218;7801.609919504031;7619.314261716444;7635.312821846032;7691.346235569983;7693.461457697963;7707.421943354243;1902.6765449873485;2161.686555449459;2251.5834570604447;2276.3284830974903;2280.247518318951;2244.618414869468;2269.4893648929024;2272.5682120397155;2275.6358982562792;2276.6015947209253;2153.0526568309892;2155.741311042669;2155.8490905636613;2165.5127596290786;2228.075348730283;1892.858035647325;2131.7335333083365;2163.102312540294;2193.9780602193932;2200.0429813031224;2212.2920665387082;2216.56776928499;2224.7552769195377;2230.9888450557805;2233.3634914049417;7641.38868890493;7670.616469176519;7702.114256860476;7707.845843083107;7727.150013498511;4453.064856380164;4570.200214962369;4578.130155270521;4586.587207151339;4595.287730401793;2863.5132027555364;2876.956845647317;2939.911802645924;2975.3156773941896;2977;945.4469135555709;961.1157734883924;966.3187452845727;980.2990861533966;988.8318985772436;10411.323263987817;10430.530626121843;10439.79120417595;10444.21668374875;10450.372977621368;4234.428352172479;4239.745615263032;4380.912381752347;4382.671299652538;4387.846425375096;8223.177682231848;8266.586670666442;8277.461964972377;8282;8287.8342433151;4502.099580083996;4532.818687252473;4547.386102876069;4550.658700597469;4555.407796986437;3677.264547090539;4109.958900411018;4241.512226093977;4242.342436922282;4263.850765223202;3496.5104885316077;3496.755227134076;3573.5890372607482;3592.2815436912724;3644.1982763791925;1034.849946757716;1061.304845326297;1061.6814955513314;1066.0512144191675;1070.240129508058;755.5504474837463;766.4979438467813;892.8526793079199;898.2215213876561;907.8910530736222;5362.302900622894;5417.133258678593;5630.774769009194;5702.800401985911;5712.171735098387;834.3825569078838;852.4288726553224;896.3277541843618;922.5894476957824;923.8983711791698;3584.229390681016;3635.8909232723063;3751.681107105872;3779.7165212609166;3836.5396152461885;9285;9688.70933871985;9711.562979665932;9738.415695058178;9774.364666296668;8881.200691937756;9396.060393960686;9614.134727874385;9632.518374081408;9640.566174522164;7003.754868579677;7051.612161331073;7138.39323657495;7187.065681461377;7212.531185472927;5370.865728356823;5499.175123731472;5508.807191748269;5634.605577609692;5696.772129114789;8344.499330040217;8355.12271211514;8426.620802063799;8507.532085735096;8511.191436813493;8259.463134896212;8495.702650407453;8519.74440766778;8938.642454302015;8952.552372381486;6090.177825993612;6263.874722505616;6303.086052522451;6748.966255168692;6901.689423976033;6498.317676643885;7455.179930207782;7482.738104166328;7506.361959233526;7517.586532740752;6726.495512836655;6809.965950170217;6823.215330237086;6851.623160726208;6967.7212911482975;6656.467482601477;6674.899876501953;6731.293214212633;6837.760678376432;6853;6337.493000559852;6414.807555773335;6419.935800641933;6548.1814773153355;6609.4712423007;4724.551167639069;4857.198562237191;4896.92654610174;5022.949770502249;5046.873828154178;4720.315554244684;4771.06964141989;4835.492273311252;4918.95081049185;4960.875978100432 06:02:00 INFO - PROCESS | 5991 | |4;prototype.html;287.3649235190231;301.70432975683843;302.64439283841483;303.78431313767226;306.6749245799452;4941.813964648481;4973.353464049673;4996.850094497162;5031.0692521883475;5064.518870707286;4908.558229759321;4928.310036594879;4982.402111746586;4983.5265649763305;4988.700677959316;3898.4152377143514;3907.902302442433;3909.6872250219913;3922.4704664870233;3925.725199236055;3921.607839216084;3931.842726290945;3932;3934.803259837011;3942.1327307992337;3806.4290356446477;3868.651821336079;3894.571597124314;3896.9610303897025;3903.6291552302487;3830.0616348994395;3859.1895701902636;3862.2275544890854;3882.786446745428;3883.572806991229;3399.6940275375086;3401.523786669868;3413.8805141820167;3421.7775844570024;3426.3489936911906;4821.831235906727;4835.468098509161;4840.7337596432535;4843.159599352223;4848.490908454597;4350;4424.734515929054;4441.644668426518;4450.755208463534;4460.375547423363;5216.426193118754;5234.738263086831;5242.895142097137;5244.79020839166;5250.264962905197;3740.1397678533817;3745.9625403745886;3754.7371683982133;3755.4179102239195;3760.9435858462143;5159.174532074888;5260.815871444481;5317.9468205317835;5489.752961116759;5493.148561972901;3855.5951625079524;3876.8061596920043;3879.8254078566533;3888.047428380065;3897.2595206910596;3918.4717959995623;3929.685625149981;3935.193285376491;3940.5074365704286;3950.9209815804097;4195;4247.851325203603;4417.491988421309;4421.7789110544345;4453.35426363182;5174.844754657366;5184.818531351385;5190.6885586864155;5196.220566914993;5211.687298762086;1347.7169794343101;1368.9657758556116;1376.8416632087237;1381.5371850430017;1382.184511138413;865.8614621660504;908.3641450984337;945.1540870920625;954.6754103604669;955.5461155950868;4649.558291962258;4657.767111644404;4664.626829853603;4674.579287864109;4676.018036212434;5362.168863826113;5373.650712703662;5380.892382152413;5381.704006279692;5397.676139431646;4543.750093744876;4643.257078867365;4651.418572678415;4658.697184682985;4687.554682305175;2892.392597554537;2892.7107289270903;2914.21316244617;2923.5760814681753;2938.3682508260827;5214.191800270964;5219.686818790885;5224.660397074254;5231.24146998683;5239.266502689627;5445.727713614304;5596.58025648078;5631.63394379364;5655.434456554394;5671.461211184931;5192.792288308501;5203.973980130075;5205.401378841481;5208;5216.478352164753;5410.296661433988;5439.184122381675;5444.50999410055;5449.891002179855;5490.6431081979545;5068;5080.49195080489;5307.787688492417;5328.920066198933;5345;5049.8737531562;5201.791928322976;5219.608529360237;5225.947740522546;5250.238715386324;3764.1906989997283;3793.089658482;3794.2411517697124;3809.1619843634357;3817.370133927871;5236.266922630759;5473.808416705396;5495.477929596682;5496.1755736639825;5502.642328248651;5275.419703832498;5288.7355632219005;5288.947110528846;5311.097113490639;5339.332583427072;5287.206918962186;5296.470352964673;5297.205419186998;5310.495502927216;5314.415414304501;4954.380702412199;5185.170372740344;5204.427512973494;5214.478552144755;5216.739163041909;5329.280547126088;5348.5186333230195;5371.704556249444;5373.462653734595;5377.354717433933;5241.868953276046;5255.369355677343;5263.157894736823;5267.762950667153;5273.868153296198 06:02:00 INFO - PROCESS | 5991 | |5;yui.html;761.7905076104071;794.384352127101;799.3804801279005;801.7314199743088;809.2918696140877;11976.580819671302;12021.158518903669;12104.939475302634;12146.271223726582;12183;12303.938480307608;12326.81509777354;12340;12349.62951111466;12362.690932726686;629.5593084840607;758.8709919313702;780.4692808889981;788.247223901173;792.5442870349543;789.6722860013087;793.3494534481698;793.714262865368;793.8729803231485;794.241499368102;843.7679638099542;844.9535275559872;845.5434065604566;845.7082306604211;846.174979395091;659.22541014308;676.5636164673758;677.7153595489906;814.4217605500043;845.4800297816829;615.3630991923338;616.3682225718629;616.7594638091148;616.8272883592601;617.197643064015;12121;12163.20939138962;12168.391580420943;12181.756364872654;12196.39018049103;12908.741825163537;13090.149140305944;13131.671708207276;13421.530246441425;13773.38019789112;9694.757631059209;10636.095931845803;10881.292715973437;11330.206885518017;11800.173987820855;3298.736101111905;3334;3341.866325346983;3362.0922350965348;3450.05123591012;40311;41229.79385103085;41619.1676166475;41673.999999999694;41785.373219401736;9784.608615655294;9898.802023959624;10054.095131438205;10086.394816311045;10161.390316581028;14979.925100374428;14991.925040374947;15001.549953501413;15008.624784380478;15024.248787560797;7033.542819716702;7046.788596342118;7142.750003749844;7246.094238220223;7279.563226206445;3870;3896.123372241223;3897.512810898638;3902.414637804295;3913.099987002948;2873.324768679359;3200.5519227308196;3329.217633856042;3338.9499157512655;3339.4990751387;552.0670067585767;567.319216939674;569.5073761196535;572.1989215098895;577.3043482603453;598.1267349669445;617.7312868902042;654.6661202786518;660.867826434715;663.7610460234312;7693.269139431745;7878.566678832719;8001;8022.318102961313;8255.504669719836;570.2273419516496;658.8484648530865;659.8812213801561;661.4344735251291;676.4216594811463;3846.9722537002535;3862.1889403225077;3881.243157584244;3942.64516193544;3959.247742928892;50988.74505627522;51793.48206517962;51904.48095518997;51988;52115.21827172596;45269;45831.31253031207;46251.3062304059;46271;47008.764956175684;43423.78288108602;43483;43604.56395436005;43644.78177609092;44473.33290000653;7185.640717964186;7274.96362518184;7297.343239108506;7390.187079421367;7753.1859154787935;29267.56098658479;29519.26201844971;29679.10962671037;30588.84705576547;30753.846230768704;35453.46819797654;38218.426723599725;38547.80726096351;38652;39009.41485877771;9390.436573805593;9617.615295388106;9621.422714637145;9638.228941684509;9861.852072219066;10590.735231619272;10695.839562406725;10724.463776811284;10772.747602246249;10892.400917949271;8929;9974.40153590787;10055.095041446304;10802.189835762507;11324.94337528307;10975;11338.829917551408;11393;11483.540658373906;11532.94233528827;10831.133509319394;10876.45617719095;10892.836607451052;11218.270812397168;11441.599544015919;9693.757656058373;9701.07839755222;9780;9921.454320012468;10043.799124017625;8931.151540603632;9016.278697704036;9108.772280693036;9174.908250917406;9636.662716805158 06:02:00 INFO - PROCESS | 5991 | __end_tp_report 06:02:00 INFO - PROCESS | 5991 | __start_cc_report 06:02:00 INFO - PROCESS | 5991 | _x_x_mozilla_cycle_collect,1044 06:02:00 INFO - PROCESS | 5991 | __end_cc_report 06:02:00 INFO - PROCESS | 5991 | __startTimestamp1461243720823__endTimestamp 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | ------- Summary: start ------- 06:02:00 INFO - PROCESS | 5991 | Number of tests: 6 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#0] dojo.html Cycles:165 Average:4611.43 Median:4770.40 stddev:480.28 (10.1%) stddev-sans-first:454.48 06:02:00 INFO - PROCESS | 5991 | Values: 2577.3 2634.8 2649.7 2666.7 2666.8 4568.8 4619.4 4630.1 4638.8 4654.9 4624.0 4671.7 4676.8 4706.3 4713.4 4255.1 4256.2 4292.0 4318.3 4413.0 4367.7 4389.3 4391.0 4423.1 4443.9 4124.9 4203.7 4283.4 4326.2 4348.0 4321.2 4322.2 4348.8 4363.5 4363.8 4288.2 4289.9 4300.7 4304.3 4339.3 4456.7 4507.8 4550.4 4568.9 4597.7 4968.9 4974.9 4976.8 4995.3 5012.5 5004.3 5009.9 5016.8 5023.2 5069.5 4517.1 4629.4 4680.6 4700.0 4703.7 5079.8 5083.4 5099.8 5107.1 5109.4 4896.2 4915.8 4916.8 4917.5 4935.9 4846.0 4880.3 4924.8 4966.5 4978.1 4929.8 4965.2 4978.1 4988.9 5033.3 4806.6 4938.5 4945.4 4948.7 4988.9 4096.8 4120.7 4120.9 4159.7 4160.2 3650.3 3655.3 3657.3 3660.7 3690.2 4189.0 4266.1 4350.7 4351.9 4383.1 4975.9 5019.2 5025.4 5053.3 5072.3 4336.0 4369.6 4377.7 4379.4 4379.7 4331.4 4377.3 4487.5 4493.9 4516.0 4770.4 4787.6 4804.0 4840.4 4841.7 5011.7 5018.4 5024.2 5024.8 5068.7 4652.7 4763.1 4779.9 4797.0 4849.0 4916.1 4933.8 4936.2 4940.4 4980.7 4968.9 4978.8 5005.8 5015.4 5049.1 4678.3 4805.8 4861.0 4864.9 4921.7 4818.2 4824.0 4830.3 4862.3 4878.0 4762.5 4769.3 4769.6 4776.1 4812.5 4778.2 4849.4 4872.4 4919.4 4923.8 4756.5 4774.1 4775.0 4782.0 4831.6 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#1] ext.html Cycles:180 Average:39048.97 Median:34737.89 stddev:64510.45 (185.7%) stddev-sans-first:64626.70 06:02:00 INFO - PROCESS | 5991 | Values: 565.6 584.1 585.5 600.4 604.4 33828.3 34968.7 34978.0 35009.0 35056.3 36807.4 37613.6 37657.2 37670.8 37708.2 7650.0 7820.7 7825.9 7857.9 7861.7 7761.1 7875.8 7881.6 8075.1 8077.7 8067.7 8154.3 8156.1 8156.3 8156.9 8006.2 8069.7 8076.4 8082.5 8083.8 7891.0 8065.5 8110.6 8122.0 8122.9 37149.6 37480.8 37567.8 37689.6 37698.0 3114.2 3172.0 3242.3 3343.1 3720.9 28683.3 28696.0 28828.4 29410.6 29546.6 3246.1 3341.0 3378.3 3439.8 3521.8 154916.0 155745.0 156020.0 156105.0 156408.2 46460.0 46877.3 46956.5 47075.3 47114.3 49319.0 56737.7 58092.0 58555.4 58562.4 13920.3 14143.6 14155.2 14166.6 14168.6 9714.2 10335.0 10352.7 10364.2 10375.5 18041.7 18510.5 18582.6 18737.3 18759.2 6705.5 6727.7 6891.8 6951.1 7057.4 858.8 907.7 911.5 971.2 998.1 28033.3 28492.7 28636.9 28966.0 29085.1 997.0 1000.6 1007.9 1077.4 1135.1 15005.2 15108.3 15181.7 15294.2 15492.1 346736.0 352932.0 353036.0 353498.0 353853.0 48194.5 49443.0 49553.8 49783.3 49793.8 1034.5 1153.0 1163.6 1243.7 1267.0 24864.1 25517.2 26170.5 26710.2 28118.6 38714.6 38851.6 39278.2 39368.8 39377.8 177275.0 177329.0 178174.0 178346.0 178664.0 21858.5 25011.7 25796.0 25823.0 25827.4 36537.5 36563.0 36657.0 36871.3 37438.8 32008.7 32981.7 34239.0 34745.3 35150.8 33953.0 33995.7 34124.5 34544.7 34730.5 33518.0 34049.8 34120.0 34422.3 34464.8 29840.6 30912.0 31207.2 31329.5 31358.8 23980.6 24430.9 24469.4 24550.4 24575.3 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#2] jquery.html Cycles:180 Average:23476.24 Median:40947.29 stddev:64707.46 (158.0%) stddev-sans-first:64865.70 06:02:00 INFO - PROCESS | 5991 | Values: 359.3 360.0 363.2 366.1 377.9 15604.9 16189.5 16811.5 16849.2 16859.5 15992.3 16651.4 16827.4 17409.9 17475.6 5048.8 5207.6 5251.2 5251.6 5254.6 3604.0 3815.1 5180.6 5633.1 5950.4 5868.4 5873.8 5903.9 5913.2 5919.2 5734.7 5758.0 5892.1 5896.5 5899.6 3285.4 4918.5 5154.2 5191.5 5192.2 18661.8 19034.5 19126.5 20278.4 20295.6 1829.0 1838.3 1979.8 1987.7 2020.5 12274.8 12656.2 12903.1 12930.9 13490.3 1707.4 1796.6 1805.7 1819.5 1824.7 62297.0 62859.7 64112.0 64278.4 64775.7 9000.1 9206.1 9498.0 9566.7 9612.7 12879.8 12917.2 13061.2 13123.6 13151.7 7113.6 7234.3 7300.6 7412.3 7435.5 7011.2 7108.5 7174.7 7196.1 7220.2 5991.4 6083.9 6133.1 6160.5 6227.9 1582.2 1622.8 1623.7 1644.2 1678.2 853.6 902.9 962.4 966.3 974.2 15490.8 16173.4 16220.4 16322.3 16348.3 888.7 903.9 924.0 947.9 957.4 7097.7 9935.7 9960.4 9972.9 10072.2 383941.0 388571.0 397429.0 401889.0 403334.0 61820.0 63213.7 64080.7 64827.4 65298.3 966.6 976.7 977.8 979.2 991.6 14902.9 14977.6 15080.6 15154.2 15349.5 29460.0 29854.4 30569.2 31295.4 31473.7 40623.4 40738.6 40817.0 41077.6 41386.2 7243.3 7379.2 7589.8 7631.1 7790.6 8643.7 11565.5 11899.1 11922.7 12047.0 6781.6 9805.7 10335.6 10500.2 10557.5 10028.5 10313.9 10458.3 10463.0 10703.5 10404.9 10538.8 10662.0 10691.8 11284.2 7238.5 7566.4 7659.0 7702.5 7828.0 8548.6 9774.2 9987.3 10116.6 10476.9 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#3] mootools.html Cycles:180 Average:5091.18 Median:5632.69 stddev:2774.42 (49.3%) stddev-sans-first:2767.33 06:02:00 INFO - PROCESS | 5991 | Values: 1268.5 1429.9 1430.2 1543.1 1728.0 6760.4 6994.4 7567.6 7779.6 7801.6 7619.3 7635.3 7691.3 7693.5 7707.4 1902.7 2161.7 2251.6 2276.3 2280.2 2244.6 2269.5 2272.6 2275.6 2276.6 2153.1 2155.7 2155.8 2165.5 2228.1 1892.9 2131.7 2163.1 2194.0 2200.0 2212.3 2216.6 2224.8 2231.0 2233.4 7641.4 7670.6 7702.1 7707.8 7727.2 4453.1 4570.2 4578.1 4586.6 4595.3 2863.5 2877.0 2939.9 2975.3 2977.0 945.4 961.1 966.3 980.3 988.8 10411.3 10430.5 10439.8 10444.2 10450.4 4234.4 4239.7 4380.9 4382.7 4387.8 8223.2 8266.6 8277.5 8282.0 8287.8 4502.1 4532.8 4547.4 4550.7 4555.4 3677.3 4110.0 4241.5 4242.3 4263.9 3496.5 3496.8 3573.6 3592.3 3644.2 1034.8 1061.3 1061.7 1066.1 1070.2 755.6 766.5 892.9 898.2 907.9 5362.3 5417.1 5630.8 5702.8 5712.2 834.4 852.4 896.3 922.6 923.9 3584.2 3635.9 3751.7 3779.7 3836.5 9285.0 9688.7 9711.6 9738.4 9774.4 8881.2 9396.1 9614.1 9632.5 9640.6 7003.8 7051.6 7138.4 7187.1 7212.5 5370.9 5499.2 5508.8 5634.6 5696.8 8344.5 8355.1 8426.6 8507.5 8511.2 8259.5 8495.7 8519.7 8938.6 8952.6 6090.2 6263.9 6303.1 6749.0 6901.7 6498.3 7455.2 7482.7 7506.4 7517.6 6726.5 6810.0 6823.2 6851.6 6967.7 6656.5 6674.9 6731.3 6837.8 6853.0 6337.5 6414.8 6419.9 6548.2 6609.5 4724.6 4857.2 4896.9 5022.9 5046.9 4720.3 4771.1 4835.5 4919.0 4960.9 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#4] prototype.html Cycles:180 Average:4377.88 Median:4982.96 stddev:1271.59 (25.5%) stddev-sans-first:1237.54 06:02:00 INFO - PROCESS | 5991 | Values: 287.4 301.7 302.6 303.8 306.7 4941.8 4973.4 4996.9 5031.1 5064.5 4908.6 4928.3 4982.4 4983.5 4988.7 3898.4 3907.9 3909.7 3922.5 3925.7 3921.6 3931.8 3932.0 3934.8 3942.1 3806.4 3868.7 3894.6 3897.0 3903.6 3830.1 3859.2 3862.2 3882.8 3883.6 3399.7 3401.5 3413.9 3421.8 3426.3 4821.8 4835.5 4840.7 4843.2 4848.5 4350.0 4424.7 4441.6 4450.8 4460.4 5216.4 5234.7 5242.9 5244.8 5250.3 3740.1 3746.0 3754.7 3755.4 3760.9 5159.2 5260.8 5317.9 5489.8 5493.1 3855.6 3876.8 3879.8 3888.0 3897.3 3918.5 3929.7 3935.2 3940.5 3950.9 4195.0 4247.9 4417.5 4421.8 4453.4 5174.8 5184.8 5190.7 5196.2 5211.7 1347.7 1369.0 1376.8 1381.5 1382.2 865.9 908.4 945.2 954.7 955.5 4649.6 4657.8 4664.6 4674.6 4676.0 5362.2 5373.7 5380.9 5381.7 5397.7 4543.8 4643.3 4651.4 4658.7 4687.6 2892.4 2892.7 2914.2 2923.6 2938.4 5214.2 5219.7 5224.7 5231.2 5239.3 5445.7 5596.6 5631.6 5655.4 5671.5 5192.8 5204.0 5205.4 5208.0 5216.5 5410.3 5439.2 5444.5 5449.9 5490.6 5068.0 5080.5 5307.8 5328.9 5345.0 5049.9 5201.8 5219.6 5225.9 5250.2 3764.2 3793.1 3794.2 3809.2 3817.4 5236.3 5473.8 5495.5 5496.2 5502.6 5275.4 5288.7 5288.9 5311.1 5339.3 5287.2 5296.5 5297.2 5310.5 5314.4 4954.4 5185.2 5204.4 5214.5 5216.7 5329.3 5348.5 5371.7 5373.5 5377.4 5241.9 5255.4 5263.2 5267.8 5273.9 06:02:00 INFO - PROCESS | 5991 | 06:02:00 INFO - PROCESS | 5991 | [#5] yui.html Cycles:180 Average:12550.62 Median:44871.17 stddev:14117.31 (31.5%) stddev-sans-first:14129.15 06:02:00 INFO - PROCESS | 5991 | Values: 761.8 794.4 799.4 801.7 809.3 11976.6 12021.2 12104.9 12146.3 12183.0 12303.9 12326.8 12340.0 12349.6 12362.7 629.6 758.9 780.5 788.2 792.5 789.7 793.3 793.7 793.9 794.2 843.8 845.0 845.5 845.7 846.2 659.2 676.6 677.7 814.4 845.5 615.4 616.4 616.8 616.8 617.2 12121.0 12163.2 12168.4 12181.8 12196.4 12908.7 13090.1 13131.7 13421.5 13773.4 9694.8 10636.1 10881.3 11330.2 11800.2 3298.7 3334.0 3341.9 3362.1 3450.1 40311.0 41229.8 41619.2 41674.0 41785.4 9784.6 9898.8 10054.1 10086.4 10161.4 14979.9 14991.9 15001.5 15008.6 15024.2 7033.5 7046.8 7142.8 7246.1 7279.6 3870.0 3896.1 3897.5 3902.4 3913.1 2873.3 3200.6 3329.2 3338.9 3339.5 552.1 567.3 569.5 572.2 577.3 598.1 617.7 654.7 660.9 663.8 7693.3 7878.6 8001.0 8022.3 8255.5 570.2 658.8 659.9 661.4 676.4 3847.0 3862.2 3881.2 3942.6 3959.2 50988.7 51793.5 51904.5 51988.0 52115.2 45269.0 45831.3 46251.3 46271.0 47008.8 43423.8 43483.0 43604.6 43644.8 44473.3 7185.6 7275.0 7297.3 7390.2 7753.2 29267.6 29519.3 29679.1 30588.8 30753.8 35453.5 38218.4 38547.8 38652.0 39009.4 9390.4 9617.6 9621.4 9638.2 9861.9 10590.7 10695.8 10724.5 10772.7 10892.4 8929.0 9974.4 10055.1 10802.2 11324.9 10975.0 11338.8 11393.0 11483.5 11532.9 10831.1 10876.5 10892.8 11218.3 11441.6 9693.8 9701.1 9780.0 9921.5 10043.8 8931.2 9016.3 9108.8 9174.9 9636.7 06:02:00 INFO - PROCESS | 5991 | -------- Summary: end -------- 06:02:00 INFO - PROCESS | 5991 | 06:02:01 INFO - TEST-INFO | 5991: exit 0 06:02:01 INFO - TEST-OK | dromaeo_css | took 1118006ms 06:02:01 INFO - TEST-START | kraken 06:02:01 INFO - operating with platform_type : linux_ 06:02:01 INFO - Initialising browser for kraken test... 06:02:01 INFO - TEST-INFO | started process 6169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTz3xH/profile http://localhost:51119/getInfo.html) 06:02:05 INFO - PROCESS | 6169 | __metrics Screen width/height:1600/1200 06:02:05 INFO - PROCESS | 6169 | colorDepth:24 06:02:05 INFO - PROCESS | 6169 | Browser inner width/height: 1024/697 06:02:05 INFO - PROCESS | 6169 | __metrics 06:02:06 ERROR - PROCESS | 6169 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:02:07 INFO - TEST-INFO | 6169: exit 0 06:02:07 INFO - Browser initialized. 06:02:07 INFO - Running cycle 1/1 for kraken test... 06:02:07 INFO - TEST-INFO | started process 6251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTz3xH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:19 INFO - PROCESS | 6251 | RSS: Main: 154177536 06:02:19 INFO - PROCESS | 6251 | 06:02:22 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51119/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:23 INFO - PROCESS | 6251 | RSS: Main: 209534976 06:02:23 INFO - PROCESS | 6251 | 06:02:26 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51119/tests/kraken/driver.html?testName=audio-dft) 06:02:26 INFO - PROCESS | 6251 | RSS: Main: 195399680 06:02:26 INFO - PROCESS | 6251 | 06:02:29 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51119/tests/kraken/driver.html?testName=audio-fft) 06:02:30 INFO - PROCESS | 6251 | RSS: Main: 266043392 06:02:30 INFO - PROCESS | 6251 | 06:02:32 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51119/tests/kraken/driver.html?testName=audio-oscillator) 06:02:33 INFO - PROCESS | 6251 | RSS: Main: 174104576 06:02:33 INFO - PROCESS | 6251 | 06:02:35 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:36 INFO - PROCESS | 6251 | RSS: Main: 178888704 06:02:36 INFO - PROCESS | 6251 | 06:02:39 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51119/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:39 INFO - PROCESS | 6251 | RSS: Main: 215011328 06:02:39 INFO - PROCESS | 6251 | 06:02:43 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51119/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:43 INFO - PROCESS | 6251 | RSS: Main: 215580672 06:02:43 INFO - PROCESS | 6251 | 06:02:46 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51119/tests/kraken/driver.html?testName=json-parse-financial) 06:02:47 INFO - PROCESS | 6251 | RSS: Main: 216371200 06:02:47 INFO - PROCESS | 6251 | 06:02:49 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:49 INFO - PROCESS | 6251 | RSS: Main: 200249344 06:02:49 INFO - PROCESS | 6251 | 06:02:51 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:52 INFO - PROCESS | 6251 | RSS: Main: 203653120 06:02:52 INFO - PROCESS | 6251 | 06:02:54 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:54 INFO - PROCESS | 6251 | RSS: Main: 219369472 06:02:54 INFO - PROCESS | 6251 | 06:02:57 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:58 INFO - PROCESS | 6251 | RSS: Main: 224911360 06:02:58 INFO - PROCESS | 6251 | 06:03:01 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:01 INFO - PROCESS | 6251 | RSS: Main: 220471296 06:03:01 INFO - PROCESS | 6251 | 06:03:03 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:51119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51119/tests/kraken/driver.html?testName=ai-astar) 06:03:04 INFO - PROCESS | 6251 | RSS: Main: 283459584 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | __start_tp_report 06:03:04 INFO - PROCESS | 6251 | _x_x_mozilla_page_load 06:03:04 INFO - PROCESS | 6251 | _x_x_mozilla_page_load_details 06:03:04 INFO - PROCESS | 6251 | |i|pagename|runs| 06:03:04 INFO - PROCESS | 6251 | |0;ai-astar;111;114;108;113;112;113;102;113;113;114 06:03:04 INFO - PROCESS | 6251 | |1;audio-beat-detection;161;136;165;183;130;159;167;133;182;134 06:03:04 INFO - PROCESS | 6251 | |2;audio-dft;161;161;160;161;162;161;162;162;161;162 06:03:04 INFO - PROCESS | 6251 | |3;audio-fft;77;74;101;107;74;73;76;118;104;73 06:03:04 INFO - PROCESS | 6251 | |4;audio-oscillator;94;94;157;94;93;94;146;95;93;142 06:03:04 INFO - PROCESS | 6251 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;116;117 06:03:04 INFO - PROCESS | 6251 | |6;imaging-darkroom;147;148;146;147;146;147;145;146;145;145 06:03:04 INFO - PROCESS | 6251 | |7;imaging-desaturate;95;95;94;94;94;94;95;95;94;94 06:03:04 INFO - PROCESS | 6251 | |8;json-parse-financial;64;65;63;65;64;65;64;88;62;61 06:03:04 INFO - PROCESS | 6251 | |9;json-stringify-tinderbox;64;65;64;63;64;64;64;64;64;65 06:03:04 INFO - PROCESS | 6251 | |10;stanford-crypto-aes;78;80;79;78;80;80;79;79;80;79 06:03:04 INFO - PROCESS | 6251 | |11;stanford-crypto-ccm;136;143;136;140;130;132;138;131;174;137 06:03:04 INFO - PROCESS | 6251 | |12;stanford-crypto-pbkdf2;187;175;174;185;179;181;178;185;177;174 06:03:04 INFO - PROCESS | 6251 | |13;stanford-crypto-sha256-iterative;74;73;73;74;73;75;74;71;72;70 06:03:04 INFO - PROCESS | 6251 | __end_tp_report 06:03:04 INFO - PROCESS | 6251 | __start_cc_report 06:03:04 INFO - PROCESS | 6251 | _x_x_mozilla_cycle_collect,1923 06:03:04 INFO - PROCESS | 6251 | __end_cc_report 06:03:04 INFO - PROCESS | 6251 | __startTimestamp1461243784035__endTimestamp 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | ------- Summary: start ------- 06:03:04 INFO - PROCESS | 6251 | Number of tests: 14 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.71 (3.3%) stddev-sans-first:3.94 06:03:04 INFO - PROCESS | 6251 | Values: 111.0 114.0 108.0 113.0 112.0 113.0 102.0 113.0 113.0 114.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:163.00 stddev:20.33 (12.5%) stddev-sans-first:21.45 06:03:04 INFO - PROCESS | 6251 | Values: 161.0 136.0 165.0 183.0 130.0 159.0 167.0 133.0 182.0 134.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 06:03:04 INFO - PROCESS | 6251 | Values: 161.0 161.0 160.0 161.0 162.0 161.0 162.0 162.0 161.0 162.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#3] audio-fft Cycles:10 Average:87.70 Median:73.50 stddev:17.61 (24.0%) stddev-sans-first:18.25 06:03:04 INFO - PROCESS | 6251 | Values: 77.0 74.0 101.0 107.0 74.0 73.0 76.0 118.0 104.0 73.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:94.00 stddev:26.57 (28.3%) stddev-sans-first:27.53 06:03:04 INFO - PROCESS | 6251 | Values: 94.0 94.0 157.0 94.0 93.0 94.0 146.0 95.0 93.0 142.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:03:04 INFO - PROCESS | 6251 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 06:03:04 INFO - PROCESS | 6251 | Values: 147.0 148.0 146.0 147.0 146.0 147.0 145.0 146.0 145.0 145.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:03:04 INFO - PROCESS | 6251 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:64.50 stddev:7.81 (12.1%) stddev-sans-first:8.25 06:03:04 INFO - PROCESS | 6251 | Values: 64.0 65.0 63.0 65.0 64.0 65.0 64.0 88.0 62.0 61.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:03:04 INFO - PROCESS | 6251 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 65.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.50 stddev:0.79 (1.0%) stddev-sans-first:0.71 06:03:04 INFO - PROCESS | 6251 | Values: 78.0 80.0 79.0 78.0 80.0 80.0 79.0 79.0 80.0 79.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:137.50 stddev:12.71 (9.2%) stddev-sans-first:13.41 06:03:04 INFO - PROCESS | 6251 | Values: 136.0 143.0 136.0 140.0 130.0 132.0 138.0 131.0 174.0 137.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.00 stddev:4.81 (2.7%) stddev-sans-first:4.27 06:03:04 INFO - PROCESS | 6251 | Values: 187.0 175.0 174.0 185.0 179.0 181.0 178.0 185.0 177.0 174.0 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - PROCESS | 6251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.50 stddev:1.52 (2.1%) stddev-sans-first:1.56 06:03:04 INFO - PROCESS | 6251 | Values: 74.0 73.0 73.0 74.0 73.0 75.0 74.0 71.0 72.0 70.0 06:03:04 INFO - PROCESS | 6251 | -------- Summary: end -------- 06:03:04 INFO - PROCESS | 6251 | 06:03:04 INFO - TEST-INFO | 6251: exit 0 06:03:05 INFO - TEST-OK | kraken | took 63503ms 06:03:05 INFO - SUITE-END | took 1181s 06:03:05 INFO - Completed test suite (00:19:41) 06:03:05 INFO - javascript benchmark 06:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.342777591714, 2634.841909485431, 2649.74827391398, 2666.69333026702, 2666.7733242674367, 4568.84009059683, 4619.376384188134, 4630.143423466657, 4638.837640682581, 4654.883627909304, 4624.028953919681, 4671.696339737915, 4676.812927482905, 4706.294055891618, 4713.38725965624, 4255.148970205955, 4256.170046840867, 4292.0342922842265, 4318.287482565373, 4412.97793511032, 4367.650587952956, 4389.341598760179, 4390.956090439103, 4423.071155057426, 4443.88890277744, 4124.876253712393, 4203.684723645739, 4283.4431523902, 4326.199653064194, 4347.978260108679, 4321.178975994551, 4322.157179350028, 4348.782560871944, 4363.52001279859, 4363.847265345729, 4288.206681763883, 4289.871303860889, 4300.720453170534, 4304.289792184286, 4339.305711086243, 4456.6880318377725, 4507.842225522091, 4550.362949187116, 4568.931466028012, 4597.724136551784, 4968.900621987576, 4974.900501989976, 4976.825811096594, 4995.250712393134, 5012.473690262506, 5004.324416203803, 5009.924851127236, 5016.799328026875, 5023.196288593807, 5069.543741063285, 4517.096580683843, 4629.375034370384, 4680.602148817321, 4699.95300047002, 4703.6942598730975, 5079.796808127633, 5083.440821509631, 5099.821506247264, 5107.131787596118, 5109.4379618241965, 4896.216605343128, 4915.754212289371, 4916.754162291871, 4917.483664215278, 4935.876603084952, 4845.951540484621, 4880.292357608198, 4924.75376231187, 4966.453690094087, 4978.079055374767, 4929.827456039022, 4965.155923493015, 4978.054169707744, 4988.90022199554, 5033.270175824485, 4806.639502037361, 4938.530839570235, 4945.431275403303, 4948.678335908155, 4988.900221995613, 4096.774677392772, 4120.670346372283, 4120.876373708794, 4159.667226621863, 4160.167966406731, 3650.2881938021833, 3655.3420384330543, 3657.3233951719017, 3660.731647728148, 3690.151265209017, 4189.036521600049, 4266.125444283976, 4350.73895566267, 4351.8694439166875, 4383.1452866691325, 4975.925361119586, 5019.247112933089, 5025.3718285214345, 5053.292539044537, 5072.315237442898, 4335.978320108379, 4369.60673539383, 4377.693561450732, 4379.386885835986, 4379.671524635665, 4331.436913201263, 4377.299632058855, 4487.528809475023, 4493.88765280864, 4516.0, 4770.403699537558, 4787.61699064081, 4803.975980120077, 4840.394950631171, 4841.685290456038, 5011.749412529286, 5018.447970723145, 5024.246363045426, 5024.824131155392, 5068.670536415121, 4652.674312798072, 4763.1426343258545, 4779.928301075556, 4797.009553366561, 4848.951510484992, 4916.0905232532095, 4933.777979990838, 4936.185529387611, 4940.357753492023, 4980.701157930535, 4968.850934471971, 4978.800847966041, 5005.77474013663, 5015.423226328873, 5049.141645920129, 4678.251479763221, 4805.7597120143155, 4860.9513904861915, 4864.92702609454, 4921.729304888266, 4818.156822556109, 4823.975880120577, 4830.347903033186, 4862.343583616166, 4877.95122048775, 4762.476127626028, 4769.260764581495, 4769.642276829182, 4776.068666609977, 4812.470628230962, 4778.187708089564, 4849.393825771778, 4872.366592342973, 4919.434265059564, 4923.803047878045, 4756.500567440507, 4774.092922344744, 4774.976125119352, 4782.0, 4831.589314908131], "value": 4581.112506387187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.558864086013, 584.1092334190362, 585.4555263604847, 600.4295918877067, 604.4167378479772, 33828.32343353132, 34968.650313496924, 34978.0, 35009.0, 35056.298874022534, 36807.4478882817, 37613.62386376136, 37657.246855062884, 37670.8116459418, 37708.24583508328, 7649.961750191242, 7820.726274580391, 7825.9217407826045, 7857.882131768028, 7861.724839630614, 7761.068671759397, 7875.763727088168, 7881.645325960346, 8075.111737708848, 8077.676892924276, 8067.717629882955, 8154.306883914875, 8156.143604921487, 8156.347492200639, 8156.877646835303, 8006.23940725633, 8069.7175598853755, 8076.394270429682, 8082.5150490970145, 8083.838323233532, 7890.9605451972375, 8065.516069035877, 8110.553919534483, 8121.95939020307, 8122.918770812275, 37149.628503714885, 37480.81259593712, 37567.81216093929, 37689.623103768885, 37698.0, 3114.174743692923, 3171.952420713691, 3242.270489139948, 3343.1474973881504, 3720.9069773255887, 28683.28291792701, 28696.0, 28828.42343153146, 29410.558841617392, 29546.556801647992, 3246.107320486885, 3341.0, 3378.3074469733647, 3439.793612383265, 3521.8239088045493, 154916.0, 155745.0, 156020.0, 156105.0, 156408.21795891062, 46460.0, 46877.29684054742, 46956.5304346959, 47075.293870591966, 47114.29328560075, 49319.0, 56737.716311419004, 58092.0, 58555.41444585499, 58562.4143758557, 13920.30398480072, 14143.575692729235, 14155.221462819643, 14166.575002749934, 14168.64578385528, 9714.174295184988, 10335.0, 10352.689419317432, 10364.170866330676, 10375.533101010322, 18041.7293740594, 18510.537236568925, 18582.628347432976, 18737.250509979447, 18759.15583798705, 6705.48544295889, 6727.697253623599, 6891.75878844238, 6951.096357473496, 7057.36483716468, 858.8239410920746, 907.6732376344511, 911.5260064766417, 971.1696499492832, 998.1316254858319, 28033.299167520567, 28492.715072849005, 28636.856815716204, 28966.0, 29085.127446176648, 996.9631583153584, 1000.6147633161286, 1007.9294449388619, 1077.42357838556, 1135.0975974100609, 15005.17471539054, 15108.320125594375, 15181.696366072616, 15294.158821264937, 15492.147931863856, 346736.0, 352932.0, 353036.0, 353498.0, 353853.0, 48194.5180548197, 49443.0, 49553.752231239334, 49783.25325120126, 49793.75103124534, 1034.4879284754095, 1152.9596464123715, 1163.5752950173126, 1243.682860870454, 1267.043382246398, 24864.12975545847, 25517.23448296554, 26170.476590468465, 26710.19869403921, 28118.578221327105, 38714.612853872226, 38851.61148388593, 39278.21443571056, 39368.80315598404, 39377.80311098426, 177275.0, 177329.0, 178174.0, 178346.0, 178664.0, 21858.45353866166, 25011.74988250167, 25796.0, 25823.0, 25827.354316141496, 36537.45193822148, 36563.0, 36657.0, 36871.262574747816, 37438.8128059358, 32008.67991320057, 32981.67018329786, 34239.0, 34745.30509389849, 35150.824245878604, 33953.0, 33995.66004339925, 34124.488132678525, 34544.654553454144, 34730.479042814884, 33518.0, 34049.82975085109, 34120.0, 34422.31155376929, 34464.82767586146, 29840.552391713707, 30912.0, 31207.219819504695, 31329.49364050916, 31358.84320578474, 23980.640290396008, 24430.878357234014, 24469.38826529351, 24550.386240344134, 24575.262742117764], "value": 16682.136526639828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.33881657749737, 359.98560057597683, 363.17921497415836, 366.1359192306157, 377.8658576205449, 15604.921975390122, 16189.514314570568, 16811.495655130366, 16849.241784119728, 16859.494215173534, 15992.280347384367, 16651.417200397987, 16827.41104061358, 17409.91295043526, 17475.563110922234, 5048.7980480780725, 5207.557357624588, 5251.212318152269, 5251.579873610102, 5254.632175747699, 3604.0, 3815.084379748868, 5180.585553155757, 5633.0987042073275, 5950.404959504058, 5868.3838196989345, 5873.794417195399, 5903.852403689899, 5913.231279933624, 5919.23050003499, 5734.7419366128415, 5758.0, 5892.14563888236, 5896.528277737771, 5899.557533185029, 3285.4250506161325, 4918.483559226265, 5154.201098829687, 5191.454897235773, 5192.247124167013, 18661.813381866144, 19034.52413689655, 19126.52183695405, 20278.391648250577, 20295.5940881183, 1828.9634207315912, 1838.347386677737, 1979.8119178678003, 1987.7018447232886, 2020.4847763820278, 12274.754504909852, 12656.177348472413, 12903.096783225177, 12930.935345323307, 13490.258035808027, 1707.4024091567976, 1796.6496533176037, 1805.702059160237, 1819.5087326421924, 1824.6533158699804, 62297.0, 62859.6857015712, 64112.0, 64278.35721642771, 64775.67612161956, 9000.099990000948, 9206.125418085272, 9497.952510237405, 9566.712998610054, 9612.711618651452, 12879.806802897963, 12917.160384574972, 13061.21632702022, 13123.60629181107, 13151.67120821968, 7113.573185608777, 7234.312740289769, 7300.598467084362, 7412.295831896069, 7435.51669141504, 7011.193712723, 7108.537945033556, 7174.713011479483, 7196.0645116134565, 7220.241874603196, 5991.430814072656, 6083.878322433527, 6133.1413602095745, 6160.507159427235, 6227.937720622826, 1582.2484319947932, 1622.7971503562055, 1623.699615571123, 1644.1861278667136, 1678.211240716861, 853.6158728572043, 902.8555431130987, 962.41292811385, 966.2656381150376, 974.1524873360222, 15490.845091549165, 16173.353065877232, 16220.35118595243, 16322.347106115622, 16348.34606615722, 888.706726780161, 903.9231665308391, 924.0159230419582, 947.9052094790466, 957.4207604399378, 7097.716091356391, 9935.701928942144, 9960.352577082467, 9972.900270997197, 10072.194224462026, 383941.0, 388571.0, 397429.0, 401889.0, 403334.0, 61820.0, 63213.683931580046, 64080.67959660265, 64827.35172648307, 65298.34701653018, 966.6230170233614, 976.72651657536, 977.8191034658611, 979.1823827104305, 991.613270824379, 14902.85097149058, 14977.643444158395, 15080.622984425478, 15154.242287885781, 15349.462768803038, 29460.0, 29854.402911941204, 30569.23576910595, 31295.374092517566, 31473.685263147076, 40623.39064914088, 40738.59261407348, 40817.0, 41077.589224107374, 41386.172276554906, 7243.311885370881, 7379.188289288067, 7589.810254743676, 7631.122420921665, 7790.61046947639, 8643.654253829776, 11565.502227015839, 11899.107566932342, 11922.701932451759, 12047.0, 6781.559198652072, 9805.656802011896, 10335.553022576996, 10500.159987201157, 10557.472126393495, 10028.498575071364, 10313.896861031593, 10458.26792124544, 10463.0, 10703.518341674799, 10404.930545488947, 10538.78922421532, 10662.0, 10691.786164276826, 11284.153688473561, 7238.493305468567, 7566.432517561095, 7658.961705191438, 7702.4608277422285, 7828.021497312836, 8548.572571371282, 9774.218062555121, 9987.25095617817, 10116.64591739315, 10476.895231047592], "value": 8137.267542294882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.549664868972, 1429.9285035748212, 1430.1919415530228, 1543.1435553267938, 1728.0409372798092, 6760.357766012227, 6994.440444764419, 7567.583782891938, 7779.572123533218, 7801.609919504031, 7619.314261716444, 7635.312821846032, 7691.346235569983, 7693.461457697963, 7707.421943354243, 1902.6765449873485, 2161.686555449459, 2251.5834570604447, 2276.3284830974903, 2280.247518318951, 2244.618414869468, 2269.4893648929024, 2272.5682120397155, 2275.6358982562792, 2276.6015947209253, 2153.0526568309892, 2155.741311042669, 2155.8490905636613, 2165.5127596290786, 2228.075348730283, 1892.858035647325, 2131.7335333083365, 2163.102312540294, 2193.9780602193932, 2200.0429813031224, 2212.2920665387082, 2216.56776928499, 2224.7552769195377, 2230.9888450557805, 2233.3634914049417, 7641.38868890493, 7670.616469176519, 7702.114256860476, 7707.845843083107, 7727.150013498511, 4453.064856380164, 4570.200214962369, 4578.130155270521, 4586.587207151339, 4595.287730401793, 2863.5132027555364, 2876.956845647317, 2939.911802645924, 2975.3156773941896, 2977.0, 945.4469135555709, 961.1157734883924, 966.3187452845727, 980.2990861533966, 988.8318985772436, 10411.323263987817, 10430.530626121843, 10439.79120417595, 10444.21668374875, 10450.372977621368, 4234.428352172479, 4239.745615263032, 4380.912381752347, 4382.671299652538, 4387.846425375096, 8223.177682231848, 8266.586670666442, 8277.461964972377, 8282.0, 8287.8342433151, 4502.099580083996, 4532.818687252473, 4547.386102876069, 4550.658700597469, 4555.407796986437, 3677.264547090539, 4109.958900411018, 4241.512226093977, 4242.342436922282, 4263.850765223202, 3496.5104885316077, 3496.755227134076, 3573.5890372607482, 3592.2815436912724, 3644.1982763791925, 1034.849946757716, 1061.304845326297, 1061.6814955513314, 1066.0512144191675, 1070.240129508058, 755.5504474837463, 766.4979438467813, 892.8526793079199, 898.2215213876561, 907.8910530736222, 5362.302900622894, 5417.133258678593, 5630.774769009194, 5702.800401985911, 5712.171735098387, 834.3825569078838, 852.4288726553224, 896.3277541843618, 922.5894476957824, 923.8983711791698, 3584.229390681016, 3635.8909232723063, 3751.681107105872, 3779.7165212609166, 3836.5396152461885, 9285.0, 9688.70933871985, 9711.562979665932, 9738.415695058178, 9774.364666296668, 8881.200691937756, 9396.060393960686, 9614.134727874385, 9632.518374081408, 9640.566174522164, 7003.754868579677, 7051.612161331073, 7138.39323657495, 7187.065681461377, 7212.531185472927, 5370.865728356823, 5499.175123731472, 5508.807191748269, 5634.605577609692, 5696.772129114789, 8344.499330040217, 8355.12271211514, 8426.620802063799, 8507.532085735096, 8511.191436813493, 8259.463134896212, 8495.702650407453, 8519.74440766778, 8938.642454302015, 8952.552372381486, 6090.177825993612, 6263.874722505616, 6303.086052522451, 6748.966255168692, 6901.689423976033, 6498.317676643885, 7455.179930207782, 7482.738104166328, 7506.361959233526, 7517.586532740752, 6726.495512836655, 6809.965950170217, 6823.215330237086, 6851.623160726208, 6967.7212911482975, 6656.467482601477, 6674.899876501953, 6731.293214212633, 6837.760678376432, 6853.0, 6337.493000559852, 6414.807555773335, 6419.935800641933, 6548.1814773153355, 6609.4712423007, 4724.551167639069, 4857.198562237191, 4896.92654610174, 5022.949770502249, 5046.873828154178, 4720.315554244684, 4771.06964141989, 4835.492273311252, 4918.95081049185, 4960.875978100432], "value": 4129.592106021364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.3649235190231, 301.70432975683843, 302.64439283841483, 303.78431313767226, 306.6749245799452, 4941.813964648481, 4973.353464049673, 4996.850094497162, 5031.0692521883475, 5064.518870707286, 4908.558229759321, 4928.310036594879, 4982.402111746586, 4983.5265649763305, 4988.700677959316, 3898.4152377143514, 3907.902302442433, 3909.6872250219913, 3922.4704664870233, 3925.725199236055, 3921.607839216084, 3931.842726290945, 3932.0, 3934.803259837011, 3942.1327307992337, 3806.4290356446477, 3868.651821336079, 3894.571597124314, 3896.9610303897025, 3903.6291552302487, 3830.0616348994395, 3859.1895701902636, 3862.2275544890854, 3882.786446745428, 3883.572806991229, 3399.6940275375086, 3401.523786669868, 3413.8805141820167, 3421.7775844570024, 3426.3489936911906, 4821.831235906727, 4835.468098509161, 4840.7337596432535, 4843.159599352223, 4848.490908454597, 4350.0, 4424.734515929054, 4441.644668426518, 4450.755208463534, 4460.375547423363, 5216.426193118754, 5234.738263086831, 5242.895142097137, 5244.79020839166, 5250.264962905197, 3740.1397678533817, 3745.9625403745886, 3754.7371683982133, 3755.4179102239195, 3760.9435858462143, 5159.174532074888, 5260.815871444481, 5317.9468205317835, 5489.752961116759, 5493.148561972901, 3855.5951625079524, 3876.8061596920043, 3879.8254078566533, 3888.047428380065, 3897.2595206910596, 3918.4717959995623, 3929.685625149981, 3935.193285376491, 3940.5074365704286, 3950.9209815804097, 4195.0, 4247.851325203603, 4417.491988421309, 4421.7789110544345, 4453.35426363182, 5174.844754657366, 5184.818531351385, 5190.6885586864155, 5196.220566914993, 5211.687298762086, 1347.7169794343101, 1368.9657758556116, 1376.8416632087237, 1381.5371850430017, 1382.184511138413, 865.8614621660504, 908.3641450984337, 945.1540870920625, 954.6754103604669, 955.5461155950868, 4649.558291962258, 4657.767111644404, 4664.626829853603, 4674.579287864109, 4676.018036212434, 5362.168863826113, 5373.650712703662, 5380.892382152413, 5381.704006279692, 5397.676139431646, 4543.750093744876, 4643.257078867365, 4651.418572678415, 4658.697184682985, 4687.554682305175, 2892.392597554537, 2892.7107289270903, 2914.21316244617, 2923.5760814681753, 2938.3682508260827, 5214.191800270964, 5219.686818790885, 5224.660397074254, 5231.24146998683, 5239.266502689627, 5445.727713614304, 5596.58025648078, 5631.63394379364, 5655.434456554394, 5671.461211184931, 5192.792288308501, 5203.973980130075, 5205.401378841481, 5208.0, 5216.478352164753, 5410.296661433988, 5439.184122381675, 5444.50999410055, 5449.891002179855, 5490.6431081979545, 5068.0, 5080.49195080489, 5307.787688492417, 5328.920066198933, 5345.0, 5049.8737531562, 5201.791928322976, 5219.608529360237, 5225.947740522546, 5250.238715386324, 3764.1906989997283, 3793.089658482, 3794.2411517697124, 3809.1619843634357, 3817.370133927871, 5236.266922630759, 5473.808416705396, 5495.477929596682, 5496.1755736639825, 5502.642328248651, 5275.419703832498, 5288.7355632219005, 5288.947110528846, 5311.097113490639, 5339.332583427072, 5287.206918962186, 5296.470352964673, 5297.205419186998, 5310.495502927216, 5314.415414304501, 4954.380702412199, 5185.170372740344, 5204.427512973494, 5214.478552144755, 5216.739163041909, 5329.280547126088, 5348.5186333230195, 5371.704556249444, 5373.462653734595, 5377.354717433933, 5241.868953276046, 5255.369355677343, 5263.157894736823, 5267.762950667153, 5273.868153296198], "value": 3973.4791427312716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.7905076104071, 794.384352127101, 799.3804801279005, 801.7314199743088, 809.2918696140877, 11976.580819671302, 12021.158518903669, 12104.939475302634, 12146.271223726582, 12183.0, 12303.938480307608, 12326.81509777354, 12340.0, 12349.62951111466, 12362.690932726686, 629.5593084840607, 758.8709919313702, 780.4692808889981, 788.247223901173, 792.5442870349543, 789.6722860013087, 793.3494534481698, 793.714262865368, 793.8729803231485, 794.241499368102, 843.7679638099542, 844.9535275559872, 845.5434065604566, 845.7082306604211, 846.174979395091, 659.22541014308, 676.5636164673758, 677.7153595489906, 814.4217605500043, 845.4800297816829, 615.3630991923338, 616.3682225718629, 616.7594638091148, 616.8272883592601, 617.197643064015, 12121.0, 12163.20939138962, 12168.391580420943, 12181.756364872654, 12196.39018049103, 12908.741825163537, 13090.149140305944, 13131.671708207276, 13421.530246441425, 13773.38019789112, 9694.757631059209, 10636.095931845803, 10881.292715973437, 11330.206885518017, 11800.173987820855, 3298.736101111905, 3334.0, 3341.866325346983, 3362.0922350965348, 3450.05123591012, 40311.0, 41229.79385103085, 41619.1676166475, 41673.999999999694, 41785.373219401736, 9784.608615655294, 9898.802023959624, 10054.095131438205, 10086.394816311045, 10161.390316581028, 14979.925100374428, 14991.925040374947, 15001.549953501413, 15008.624784380478, 15024.248787560797, 7033.542819716702, 7046.788596342118, 7142.750003749844, 7246.094238220223, 7279.563226206445, 3870.0, 3896.123372241223, 3897.512810898638, 3902.414637804295, 3913.099987002948, 2873.324768679359, 3200.5519227308196, 3329.217633856042, 3338.9499157512655, 3339.4990751387, 552.0670067585767, 567.319216939674, 569.5073761196535, 572.1989215098895, 577.3043482603453, 598.1267349669445, 617.7312868902042, 654.6661202786518, 660.867826434715, 663.7610460234312, 7693.269139431745, 7878.566678832719, 8001.0, 8022.318102961313, 8255.504669719836, 570.2273419516496, 658.8484648530865, 659.8812213801561, 661.4344735251291, 676.4216594811463, 3846.9722537002535, 3862.1889403225077, 3881.243157584244, 3942.64516193544, 3959.247742928892, 50988.74505627522, 51793.48206517962, 51904.48095518997, 51988.0, 52115.21827172596, 45269.0, 45831.31253031207, 46251.3062304059, 46271.0, 47008.764956175684, 43423.78288108602, 43483.0, 43604.56395436005, 43644.78177609092, 44473.33290000653, 7185.640717964186, 7274.96362518184, 7297.343239108506, 7390.187079421367, 7753.1859154787935, 29267.56098658479, 29519.26201844971, 29679.10962671037, 30588.84705576547, 30753.846230768704, 35453.46819797654, 38218.426723599725, 38547.80726096351, 38652.0, 39009.41485877771, 9390.436573805593, 9617.615295388106, 9621.422714637145, 9638.228941684509, 9861.852072219066, 10590.735231619272, 10695.839562406725, 10724.463776811284, 10772.747602246249, 10892.400917949271, 8929.0, 9974.40153590787, 10055.095041446304, 10802.189835762507, 11324.94337528307, 10975.0, 11338.829917551408, 11393.0, 11483.540658373906, 11532.94233528827, 10831.133509319394, 10876.45617719095, 10892.836607451052, 11218.270812397168, 11441.599544015919, 9693.757656058373, 9701.07839755222, 9780.0, 9921.454320012468, 10043.799124017625, 8931.151540603632, 9016.278697704036, 9108.772280693036, 9174.908250917406, 9636.662716805158], "value": 5930.151008321296, "unit": "score"}], "name": "dromaeo_css", "value": 6265.876769856882, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 108.0, 113.0, 112.0, 113.0, 102.0, 113.0, 113.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 136.0, 165.0, 183.0, 130.0, 159.0, 167.0, 133.0, 182.0, 134.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 101.0, 107.0, 74.0, 73.0, 76.0, 118.0, 104.0, 73.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 157.0, 94.0, 93.0, 94.0, 146.0, 95.0, 93.0, 142.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 65.0, 64.0, 65.0, 64.0, 88.0, 62.0, 61.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 78.0, 80.0, 80.0, 79.0, 79.0, 80.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 136.0, 140.0, 130.0, 132.0, 138.0, 131.0, 174.0, 137.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 175.0, 174.0, 185.0, 179.0, 181.0, 178.0, 185.0, 177.0, 174.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 74.0, 73.0, 75.0, 74.0, 71.0, 72.0, 70.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1584.2000000000003, "alertThreshold": 2.0}]} 06:03:05 INFO - Return code: 0 06:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:03:05 ERROR - # TBPL SUCCESS # 06:03:05 INFO - Running post-action listener: _resource_record_post_action 06:03:05 INFO - Running post-run listener: _resource_record_post_run 06:03:06 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518324224; Read time: 56; Write time: 410784 06:03:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 163123200; Read time: 0; Write time: 149396 06:03:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284033024; Read time: 56; Write time: 151856 06:03:06 INFO - Running post-run listener: _upload_blobber_files 06:03:06 INFO - Blob upload gear active. 06:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:07 INFO - (blobuploader) - INFO - Done attempting. 06:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:08 INFO - (blobuploader) - INFO - Done attempting. 06:03:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:08 INFO - Return code: 0 06:03:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4200ac1732baaa178755bcf2e1d4b84f91ccd998326b4bb4d9b561486cdb34a84db9518e63efc1b45bd8b79eb01e7da9144cabd63b292ee452c75272a1b5b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49bf9328b1837c77116ee2ba1a130f41964ce534eea15656dc118e2cf82f33a2f2fc4f54477d27ae461cba3051c7d07b391170f66e5b27678517249d7a7b7c89"} 06:03:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:08 INFO - Contents: 06:03:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4200ac1732baaa178755bcf2e1d4b84f91ccd998326b4bb4d9b561486cdb34a84db9518e63efc1b45bd8b79eb01e7da9144cabd63b292ee452c75272a1b5b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49bf9328b1837c77116ee2ba1a130f41964ce534eea15656dc118e2cf82f33a2f2fc4f54477d27ae461cba3051c7d07b391170f66e5b27678517249d7a7b7c89"} 06:03:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:08 INFO - Copying logs to upload dir... 06:03:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.821042 ========= master_lag: 76.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-04-21 06:04:24.606657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:24.610784) ========= 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-1461241702.405957-677972523 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/e4200ac1732baaa178755bcf2e1d4b84f91ccd998326b4bb4d9b561486cdb34a84db9518e63efc1b45bd8b79eb01e7da9144cabd63b292ee452c75272a1b5b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49bf9328b1837c77116ee2ba1a130f41964ce534eea15656dc118e2cf82f33a2f2fc4f54477d27ae461cba3051c7d07b391170f66e5b27678517249d7a7b7c89"} build_url:https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/ZGCJRpw0RiGG8pdkdWmabw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4200ac1732baaa178755bcf2e1d4b84f91ccd998326b4bb4d9b561486cdb34a84db9518e63efc1b45bd8b79eb01e7da9144cabd63b292ee452c75272a1b5b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49bf9328b1837c77116ee2ba1a130f41964ce534eea15656dc118e2cf82f33a2f2fc4f54477d27ae461cba3051c7d07b391170f66e5b27678517249d7a7b7c89"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:24.918428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:24.918766) ========= 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-1461241702.405957-677972523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:25.234679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:04:25.235033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:04:25.235624) ========= ========= Total master_lag: 76.72 =========