builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1461857072.83 results: success (0) buildid: 20160428071449 builduid: 56a48c653ee24eab91fc08fb9b572b43 revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.831696) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.832150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.832440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.849600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.850004) ========= 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=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 08:24:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 12.6M=0.001s 2016-04-28 08:24:33 (12.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.991483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:32.991757) ========= 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=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020052 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:33.041040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 08:24:33.041390) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 53765e008b97622b5c7e26d22b2db016b0e53dc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 53765e008b97622b5c7e26d22b2db016b0e53dc1 --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=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 08:24:33,149 truncating revision to first 12 chars 2016-04-28 08:24:33,149 Setting DEBUG logging. 2016-04-28 08:24:33,149 attempt 1/10 2016-04-28 08:24:33,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/53765e008b97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 08:24:33,881 unpacking tar archive at: mozilla-central-53765e008b97/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 08:24:34.063088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:34.063413) ========= script_repo_revision: 53765e008b97622b5c7e26d22b2db016b0e53dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:34.063819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:34.064106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:24:34.073199) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 08:24:34.073584) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:34 INFO - MultiFileLogger online at 20160428 08:24:34 in /builds/slave/test 08:24:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:34 INFO - {'append_to_log': False, 08:24:34 INFO - 'base_work_dir': '/builds/slave/test', 08:24:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:34 INFO - 'branch': 'Firefox-Non-PGO', 08:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:34 INFO - 'config_files': ('talos/linux_config.py',), 08:24:34 INFO - 'default_actions': ('clobber', 08:24:34 INFO - 'read-buildbot-config', 08:24:34 INFO - 'download-and-extract', 08:24:34 INFO - 'populate-webroot', 08:24:34 INFO - 'create-virtualenv', 08:24:34 INFO - 'install', 08:24:34 INFO - 'run-tests'), 08:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:34 INFO - 'download_minidump_stackwalk': True, 08:24:34 INFO - 'download_symbols': 'ondemand', 08:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:34 INFO - 'installer_path': 'installer.exe', 08:24:34 INFO - 'log_level': 'info', 08:24:34 INFO - 'log_name': 'talos', 08:24:34 INFO - 'log_to_console': True, 08:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:34 INFO - 'opt_config_files': (), 08:24:34 INFO - 'pip_index': False, 08:24:34 INFO - 'sps_profile': False, 08:24:34 INFO - 'sps_profile_interval': 0, 08:24:34 INFO - 'suite': 'dromaeojs', 08:24:34 INFO - 'system_bits': '32', 08:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:34 INFO - 'title': 'talos-linux64-ix-058', 08:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:34 INFO - 'use_talos_json': True, 08:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:34 INFO - 'work_dir': 'build'} 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running clobber step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: clobber 08:24:34 INFO - rmtree: /builds/slave/test/build 08:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:34 INFO - Running post-action listener: _resource_record_post_action 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running read-buildbot-config step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: read_buildbot_config 08:24:34 INFO - Using buildbot properties: 08:24:34 INFO - { 08:24:34 INFO - "project": "", 08:24:34 INFO - "product": "firefox", 08:24:34 INFO - "script_repo_revision": "production", 08:24:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:24:34 INFO - "repository": "", 08:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:24:34 INFO - "buildid": "20160428071449", 08:24:34 INFO - "pgo_build": "False", 08:24:34 INFO - "basedir": "/builds/slave/test", 08:24:34 INFO - "buildnumber": 489, 08:24:34 INFO - "slavename": "talos-linux64-ix-058", 08:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:24:34 INFO - "platform": "ubuntu64_hw", 08:24:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:24:34 INFO - "branch": "mozilla-central", 08:24:34 INFO - "repo_path": "mozilla-central", 08:24:34 INFO - "revision": "53765e008b97622b5c7e26d22b2db016b0e53dc1", 08:24:34 INFO - "stage_platform": "linux64", 08:24:34 INFO - "builduid": "56a48c653ee24eab91fc08fb9b572b43", 08:24:34 INFO - "slavebuilddir": "test" 08:24:34 INFO - } 08:24:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:24:34 INFO - Running post-action listener: _resource_record_post_action 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running download-and-extract step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: download_and_extract 08:24:34 INFO - mkdir: /builds/slave/test/build/tests 08:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:34 INFO - https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:24:35 INFO - Downloaded 1361 bytes. 08:24:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:35 INFO - Using the following test package requirements: 08:24:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:24:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'jsshell-linux-x86_64.zip'], 08:24:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24: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')]} 08:24:35 INFO - https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:36 INFO - Downloaded 22292973 bytes. 08:24:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:24:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:24:37 INFO - Return code: 0 08:24:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:24: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')]} 08:24:37 INFO - https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:39 INFO - Downloaded 22292973 bytes. 08:24:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:24:40 INFO - Return code: 0 08:24:40 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')]} 08:24:40 INFO - https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:24:42 INFO - Downloaded 10840145 bytes. 08:24:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:24:42 INFO - Return code: 0 08:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:42 INFO - https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:24:45 INFO - Downloaded 54835148 bytes. 08:24:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:24:45 INFO - mkdir: /builds/slave/test/properties 08:24:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:45 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:45 INFO - Contents: 08:24:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:24:46 INFO - Running post-action listener: _resource_record_post_action 08:24:46 INFO - Running post-action listener: set_extra_try_arguments 08:24:46 INFO - ##### 08:24:46 INFO - ##### Running populate-webroot step. 08:24:46 INFO - ##### 08:24:46 INFO - Running pre-action listener: _resource_record_pre_action 08:24:46 INFO - Running main action method: populate_webroot 08:24:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:46 INFO - '--tppagecycles', 08:24:46 INFO - '7'], 08:24:46 INFO - 'tests': ['tsvgm']}}, 08:24:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['damp', 'tps']}, 08:24:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'tests': ['damp', 'tps']}, 08:24:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['dromaeo_dom']}, 08:24:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['a11yr', 08:24:46 INFO - 'ts_paint', 08:24:46 INFO - 'tpaint', 08:24:46 INFO - 'sessionrestore', 08:24:46 INFO - 'sessionrestore_no_auto_restore', 08:24:46 INFO - 'tabpaint']}, 08:24:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['tsvgx', 08:24:46 INFO - 'tsvgr_opacity', 08:24:46 INFO - 'tart', 08:24:46 INFO - 'tscrollx', 08:24:46 INFO - 'cart']}, 08:24:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:46 INFO - 'tsvgr_opacity', 08:24:46 INFO - 'tart', 08:24:46 INFO - 'tscrollx', 08:24:46 INFO - 'cart']}, 08:24:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'talos_options': ['--disable-e10s'], 08:24:46 INFO - 'tests': ['tp5o']}, 08:24:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'tests': ['tp5o']}, 08:24:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'talos_options': ['--disable-e10s', 08:24:46 INFO - '--xperf_path', 08:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:46 INFO - 'tests': ['tp5n']}, 08:24:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:46 INFO - 'talos_options': ['--xperf_path', 08:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:46 INFO - 'tests': ['tp5n']}}, 08:24:46 INFO - 'talos.zip': {'path': '', 08:24:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:46 INFO - Running post-action listener: _resource_record_post_action 08:24:46 INFO - ##### 08:24:46 INFO - ##### Running create-virtualenv step. 08:24:46 INFO - ##### 08:24:46 INFO - Running pre-action listener: _resource_record_pre_action 08:24:46 INFO - Running main action method: create_virtualenv 08:24:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:46 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 08:24:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:46 INFO - Using real prefix '/usr' 08:24:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:48 INFO - Installing pip.................done. 08:24:48 INFO - Return code: 0 08:24:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:48 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')]} 08:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 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')]} 08:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:24:48 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 08:24:48 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 08:24:48 INFO - Using env: {'DISPLAY': ':0', 08:24:48 INFO - 'HOME': '/home/cltbld', 08:24:48 INFO - 'LANG': 'en_US.UTF-8', 08:24:48 INFO - 'LANGUAGE': 'en_US:en', 08:24:48 INFO - 'LOGNAME': 'cltbld', 08:24:48 INFO - 'MAIL': '/var/mail/cltbld', 08:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:48 INFO - 'MOZ_NO_REMOTE': '1', 08:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:48 INFO - 'NO_EM_RESTART': '1', 08:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:48 INFO - 'PWD': '/builds/slave/test', 08:24:48 INFO - 'SHELL': '/bin/bash', 08:24:48 INFO - 'SHLVL': '1', 08:24:48 INFO - 'TERM': 'linux', 08:24:48 INFO - 'TMOUT': '86400', 08:24:48 INFO - 'USER': 'cltbld', 08:24:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:48 INFO - '_': '/tools/buildbot/bin/python'} 08:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:48 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 08:24:48 INFO - Cleaning up... 08:24:48 INFO - Return code: 0 08:24:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:24:48 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')]} 08:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 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')]} 08:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:24:48 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 08:24:48 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 08:24:48 INFO - Using env: {'DISPLAY': ':0', 08:24:48 INFO - 'HOME': '/home/cltbld', 08:24:48 INFO - 'LANG': 'en_US.UTF-8', 08:24:48 INFO - 'LANGUAGE': 'en_US:en', 08:24:48 INFO - 'LOGNAME': 'cltbld', 08:24:48 INFO - 'MAIL': '/var/mail/cltbld', 08:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:48 INFO - 'MOZ_NO_REMOTE': '1', 08:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:48 INFO - 'NO_EM_RESTART': '1', 08:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:48 INFO - 'PWD': '/builds/slave/test', 08:24:48 INFO - 'SHELL': '/bin/bash', 08:24:48 INFO - 'SHLVL': '1', 08:24:48 INFO - 'TERM': 'linux', 08:24:48 INFO - 'TMOUT': '86400', 08:24:48 INFO - 'USER': 'cltbld', 08:24:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:48 INFO - '_': '/tools/buildbot/bin/python'} 08:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:49 INFO - Downloading/unpacking psutil>=0.7.1 08:24:49 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 08:24:49 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 08:24:49 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 08:24:49 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 08:24:49 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 08:24:49 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 08:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:51 INFO - Installing collected packages: psutil 08:24:51 INFO - Running setup.py install for psutil 08:24:51 INFO - building 'psutil._psutil_linux' extension 08:24:51 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 08:24:51 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 08:24:51 INFO - building 'psutil._psutil_posix' extension 08:24:51 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 08:24:51 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 08:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:51 INFO - Successfully installed psutil 08:24:51 INFO - Cleaning up... 08:24:51 INFO - Return code: 0 08:24:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:51 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:24:51 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 08:24:51 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 08:24:51 INFO - Using env: {'DISPLAY': ':0', 08:24:51 INFO - 'HOME': '/home/cltbld', 08:24:51 INFO - 'LANG': 'en_US.UTF-8', 08:24:51 INFO - 'LANGUAGE': 'en_US:en', 08:24:51 INFO - 'LOGNAME': 'cltbld', 08:24:51 INFO - 'MAIL': '/var/mail/cltbld', 08:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:51 INFO - 'MOZ_NO_REMOTE': '1', 08:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:51 INFO - 'NO_EM_RESTART': '1', 08:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:51 INFO - 'PWD': '/builds/slave/test', 08:24:51 INFO - 'SHELL': '/bin/bash', 08:24:51 INFO - 'SHLVL': '1', 08:24:51 INFO - 'TERM': 'linux', 08:24:51 INFO - 'TMOUT': '86400', 08:24:51 INFO - 'USER': 'cltbld', 08:24:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:51 INFO - '_': '/tools/buildbot/bin/python'} 08:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:24:51 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 08:24:51 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 08:24:51 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 08:24:51 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 08:24:51 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 08:24:51 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 08:24:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:24:53 INFO - Installing collected packages: mozsystemmonitor 08:24:53 INFO - Running setup.py install for mozsystemmonitor 08:24:53 INFO - Successfully installed mozsystemmonitor 08:24:53 INFO - Cleaning up... 08:24:53 INFO - Return code: 0 08:24:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:24:53 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 08:24:53 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 08:24:53 INFO - Using env: {'DISPLAY': ':0', 08:24:53 INFO - 'HOME': '/home/cltbld', 08:24:53 INFO - 'LANG': 'en_US.UTF-8', 08:24:53 INFO - 'LANGUAGE': 'en_US:en', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MAIL': '/var/mail/cltbld', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SHLVL': '1', 08:24:53 INFO - 'TERM': 'linux', 08:24:53 INFO - 'TMOUT': '86400', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - '_': '/tools/buildbot/bin/python'} 08:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 INFO - Downloading docopt-0.6.1.tar.gz 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:56 INFO - Running setup.py install for blobuploader 08:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:56 INFO - Running setup.py install for requests 08:24:57 INFO - Running setup.py install for docopt 08:24:57 INFO - Successfully installed blobuploader requests docopt 08:24:57 INFO - Cleaning up... 08:24:57 INFO - Return code: 0 08:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:24:57 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 08:24:57 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 08:24:57 INFO - Using env: {'DISPLAY': ':0', 08:24:57 INFO - 'HOME': '/home/cltbld', 08:24:57 INFO - 'LANG': 'en_US.UTF-8', 08:24:57 INFO - 'LANGUAGE': 'en_US:en', 08:24:57 INFO - 'LOGNAME': 'cltbld', 08:24:57 INFO - 'MAIL': '/var/mail/cltbld', 08:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:57 INFO - 'MOZ_NO_REMOTE': '1', 08:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:57 INFO - 'NO_EM_RESTART': '1', 08:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:57 INFO - 'PWD': '/builds/slave/test', 08:24:57 INFO - 'SHELL': '/bin/bash', 08:24:57 INFO - 'SHLVL': '1', 08:24:57 INFO - 'TERM': 'linux', 08:24:57 INFO - 'TMOUT': '86400', 08:24:57 INFO - 'USER': 'cltbld', 08:24:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:57 INFO - '_': '/tools/buildbot/bin/python'} 08:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:57 INFO - Running setup.py (path:/tmp/pip-GEx9bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:57 INFO - Running setup.py (path:/tmp/pip-aLd8nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:57 INFO - Running setup.py (path:/tmp/pip-HbQs4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:57 INFO - Running setup.py (path:/tmp/pip-pqHYro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:57 INFO - Running setup.py (path:/tmp/pip-nfpanS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:57 INFO - Running setup.py (path:/tmp/pip-Z0oTuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:57 INFO - Running setup.py (path:/tmp/pip-SGmV06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:58 INFO - Running setup.py (path:/tmp/pip-fpZjZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:58 INFO - Running setup.py (path:/tmp/pip-PVW8gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:58 INFO - Running setup.py (path:/tmp/pip-4crJqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:58 INFO - Running setup.py (path:/tmp/pip-VDj8fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:58 INFO - Running setup.py (path:/tmp/pip-nWbQQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:58 INFO - Running setup.py (path:/tmp/pip-4cEaGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:58 INFO - Running setup.py (path:/tmp/pip-E_bEv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:58 INFO - Running setup.py (path:/tmp/pip-2oN5G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:58 INFO - Running setup.py (path:/tmp/pip-HqdDki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:58 INFO - Running setup.py (path:/tmp/pip-LuQkkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:58 INFO - Running setup.py install for manifestparser 08:24:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:58 INFO - Running setup.py install for mozcrash 08:24:58 INFO - Running setup.py install for mozdebug 08:24:59 INFO - Running setup.py install for mozdevice 08:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozfile 08:24:59 INFO - Running setup.py install for mozhttpd 08:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozinfo 08:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozInstall 08:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozleak 08:24:59 INFO - Running setup.py install for mozlog 08:24:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for moznetwork 08:24:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozprocess 08:25:00 INFO - Running setup.py install for mozprofile 08:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Running setup.py install for mozrunner 08:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Running setup.py install for mozscreenshot 08:25:00 INFO - Running setup.py install for moztest 08:25:00 INFO - Running setup.py install for mozversion 08:25:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:00 INFO - Cleaning up... 08:25:00 INFO - Return code: 0 08:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:00 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:25:00 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 08:25:00 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 08:25:00 INFO - Using env: {'DISPLAY': ':0', 08:25:00 INFO - 'HOME': '/home/cltbld', 08:25:00 INFO - 'LANG': 'en_US.UTF-8', 08:25:00 INFO - 'LANGUAGE': 'en_US:en', 08:25:00 INFO - 'LOGNAME': 'cltbld', 08:25:00 INFO - 'MAIL': '/var/mail/cltbld', 08:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:00 INFO - 'MOZ_NO_REMOTE': '1', 08:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:00 INFO - 'NO_EM_RESTART': '1', 08:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:00 INFO - 'PWD': '/builds/slave/test', 08:25:00 INFO - 'SHELL': '/bin/bash', 08:25:00 INFO - 'SHLVL': '1', 08:25:00 INFO - 'TERM': 'linux', 08:25:00 INFO - 'TMOUT': '86400', 08:25:00 INFO - 'USER': 'cltbld', 08:25:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:00 INFO - '_': '/tools/buildbot/bin/python'} 08:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:00 INFO - Running setup.py (path:/tmp/pip-RaTMMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:00 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)) 08:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:00 INFO - Running setup.py (path:/tmp/pip-XM40JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:00 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)) 08:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:00 INFO - Running setup.py (path:/tmp/pip-3E6R2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:01 INFO - Running setup.py (path:/tmp/pip-3_6AXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:01 INFO - Running setup.py (path:/tmp/pip-A1PCC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:01 INFO - Running setup.py (path:/tmp/pip-69d9eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:01 INFO - Running setup.py (path:/tmp/pip-pteZi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:01 INFO - Running setup.py (path:/tmp/pip-pEVwVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:01 INFO - Running setup.py (path:/tmp/pip-yGPMSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:01 INFO - Running setup.py (path:/tmp/pip-Qg_rOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:01 INFO - Running setup.py (path:/tmp/pip-JAMROv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:01 INFO - Running setup.py (path:/tmp/pip-Jj1X7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:01 INFO - Running setup.py (path:/tmp/pip-e_VXHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:01 INFO - Running setup.py (path:/tmp/pip-SCXVU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:01 INFO - Running setup.py (path:/tmp/pip-Aq20AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:01 INFO - Running setup.py (path:/tmp/pip-tw7233-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:01 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)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:01 INFO - Running setup.py (path:/tmp/pip-GIlLPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:02 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)) 08:25:02 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)) 08:25:02 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)) 08:25:02 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)) 08:25:02 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)) 08:25:02 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)) 08:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:03 INFO - Downloading blessings-1.6.tar.gz 08:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:03 INFO - Installing collected packages: blessings 08:25:03 INFO - Running setup.py install for blessings 08:25:04 INFO - Successfully installed blessings 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:04 INFO - Reading from file tmpfile_stdout 08:25:04 INFO - Current package versions: 08:25:04 INFO - argparse == 1.2.1 08:25:04 INFO - blessings == 1.6 08:25:04 INFO - blobuploader == 1.2.4 08:25:04 INFO - docopt == 0.6.1 08:25:04 INFO - manifestparser == 1.1 08:25:04 INFO - mozInstall == 1.12 08:25:04 INFO - mozcrash == 0.17 08:25:04 INFO - mozdebug == 0.1 08:25:04 INFO - mozdevice == 0.48 08:25:04 INFO - mozfile == 1.2 08:25:04 INFO - mozhttpd == 0.7 08:25:04 INFO - mozinfo == 0.9 08:25:04 INFO - mozleak == 0.1 08:25:04 INFO - mozlog == 3.1 08:25:04 INFO - moznetwork == 0.27 08:25:04 INFO - mozprocess == 0.22 08:25:04 INFO - mozprofile == 0.28 08:25:04 INFO - mozrunner == 6.11 08:25:04 INFO - mozscreenshot == 0.1 08:25:04 INFO - mozsystemmonitor == 0.0 08:25:04 INFO - moztest == 0.7 08:25:04 INFO - mozversion == 1.4 08:25:04 INFO - psutil == 3.1.1 08:25:04 INFO - requests == 1.2.3 08:25:04 INFO - wsgiref == 0.1.2 08:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:25:04 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 08:25:04 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 08:25:04 INFO - Using env: {'DISPLAY': ':0', 08:25:04 INFO - 'HOME': '/home/cltbld', 08:25:04 INFO - 'LANG': 'en_US.UTF-8', 08:25:04 INFO - 'LANGUAGE': 'en_US:en', 08:25:04 INFO - 'LOGNAME': 'cltbld', 08:25:04 INFO - 'MAIL': '/var/mail/cltbld', 08:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:04 INFO - 'MOZ_NO_REMOTE': '1', 08:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:04 INFO - 'NO_EM_RESTART': '1', 08:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:04 INFO - 'PWD': '/builds/slave/test', 08:25:04 INFO - 'SHELL': '/bin/bash', 08:25:04 INFO - 'SHLVL': '1', 08:25:04 INFO - 'TERM': 'linux', 08:25:04 INFO - 'TMOUT': '86400', 08:25:04 INFO - 'USER': 'cltbld', 08:25:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:04 INFO - '_': '/tools/buildbot/bin/python'} 08:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 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)) 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:25:04 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 08:25:04 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 08:25:04 INFO - Using env: {'DISPLAY': ':0', 08:25:04 INFO - 'HOME': '/home/cltbld', 08:25:04 INFO - 'LANG': 'en_US.UTF-8', 08:25:04 INFO - 'LANGUAGE': 'en_US:en', 08:25:04 INFO - 'LOGNAME': 'cltbld', 08:25:04 INFO - 'MAIL': '/var/mail/cltbld', 08:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:04 INFO - 'MOZ_NO_REMOTE': '1', 08:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:04 INFO - 'NO_EM_RESTART': '1', 08:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:04 INFO - 'PWD': '/builds/slave/test', 08:25:04 INFO - 'SHELL': '/bin/bash', 08:25:04 INFO - 'SHLVL': '1', 08:25:04 INFO - 'TERM': 'linux', 08:25:04 INFO - 'TMOUT': '86400', 08:25:04 INFO - 'USER': 'cltbld', 08:25:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:04 INFO - '_': '/tools/buildbot/bin/python'} 08:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:04 INFO - Downloading/unpacking jsonschema 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:06 INFO - warning: no files found matching '*.txt' 08:25:06 INFO - no previously-included directories found matching 'build' 08:25:06 INFO - no previously-included directories found matching 'dist' 08:25:06 INFO - no previously-included directories found matching '.git*' 08:25:06 INFO - Installing collected packages: jsonschema, functools32 08:25:07 INFO - Running setup.py install for functools32 08:25:07 INFO - warning: no files found matching '*.txt' 08:25:07 INFO - no previously-included directories found matching 'build' 08:25:07 INFO - no previously-included directories found matching 'dist' 08:25:07 INFO - no previously-included directories found matching '.git*' 08:25:07 INFO - Successfully installed jsonschema functools32 08:25:07 INFO - Cleaning up... 08:25:07 INFO - Return code: 0 08:25:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:07 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 0x7f8369152f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', '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 08:25:07 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 08:25:07 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 08:25:07 INFO - Using env: {'DISPLAY': ':0', 08:25:07 INFO - 'HOME': '/home/cltbld', 08:25:07 INFO - 'LANG': 'en_US.UTF-8', 08:25:07 INFO - 'LANGUAGE': 'en_US:en', 08:25:07 INFO - 'LOGNAME': 'cltbld', 08:25:07 INFO - 'MAIL': '/var/mail/cltbld', 08:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:07 INFO - 'MOZ_NO_REMOTE': '1', 08:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:07 INFO - 'NO_EM_RESTART': '1', 08:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:07 INFO - 'PWD': '/builds/slave/test', 08:25:07 INFO - 'SHELL': '/bin/bash', 08:25:07 INFO - 'SHLVL': '1', 08:25:07 INFO - 'TERM': 'linux', 08:25:07 INFO - 'TMOUT': '86400', 08:25:07 INFO - 'USER': 'cltbld', 08:25:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:07 INFO - '_': '/tools/buildbot/bin/python'} 08:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:07 INFO - Downloading/unpacking flake8 08:25:07 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 08:25:07 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 08:25:07 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 08:25:07 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 08:25:07 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 08:25:07 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 08:25:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:25:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:25:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:09 INFO - no previously-included directories found matching 'docs/_build' 08:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:25:10 INFO - Running setup.py install for pep8 08:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:10 INFO - no previously-included directories found matching 'docs/_build' 08:25:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:25:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:25:10 INFO - Cleaning up... 08:25:10 INFO - Return code: 0 08:25:10 INFO - Running post-action listener: _resource_record_post_action 08:25:10 INFO - Running post-action listener: _start_resource_monitoring 08:25:10 INFO - Starting resource monitoring. 08:25:10 INFO - ##### 08:25:10 INFO - ##### Running install step. 08:25:10 INFO - ##### 08:25:10 INFO - Running pre-action listener: _resource_record_pre_action 08:25:10 INFO - Running main action method: install 08:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:10 INFO - Reading from file tmpfile_stdout 08:25:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:10 INFO - Reading from file tmpfile_stdout 08:25:10 INFO - Output received: 08:25:10 INFO - Usage: mozinstall [options] installer 08:25:10 INFO - Options: 08:25:10 INFO - -h, --help show this help message and exit 08:25:10 INFO - -d DEST, --destination=DEST 08:25:10 INFO - Directory to install application into. [default: 08:25:10 INFO - "/builds/slave/test"] 08:25:10 INFO - --app=APP Application being installed. [default: firefox] 08:25:10 INFO - mkdir: /builds/slave/test/build/application 08:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:25:26 INFO - Reading from file tmpfile_stdout 08:25:26 INFO - Output received: 08:25:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:26 INFO - Running post-action listener: _resource_record_post_action 08:25:26 INFO - ##### 08:25:26 INFO - ##### Running run-tests step. 08:25:26 INFO - ##### 08:25:26 INFO - Running pre-action listener: _resource_record_pre_action 08:25:26 INFO - Running main action method: run_tests 08:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:26 INFO - Python 2.7.3 08:25:26 INFO - Return code: 0 08:25:26 INFO - grabbing minidump binary from tooltool 08:25:26 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')]} 08:25:26 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 0x19e0410>, '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 0x19e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:26 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 08:25:26 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 08:25:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:26 INFO - Return code: 0 08:25:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:25:27 INFO - Return code: 0 08:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 08:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 08:25:27 INFO - Using env: {'DISPLAY': ':0', 08:25:27 INFO - 'HOME': '/home/cltbld', 08:25:27 INFO - 'LANG': 'en_US.UTF-8', 08:25:27 INFO - 'LANGUAGE': 'en_US:en', 08:25:27 INFO - 'LOGNAME': 'cltbld', 08:25:27 INFO - 'MAIL': '/var/mail/cltbld', 08:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:27 INFO - 'MOZ_NO_REMOTE': '1', 08:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:27 INFO - 'NO_EM_RESTART': '1', 08:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:27 INFO - 'PWD': '/builds/slave/test', 08:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:27 INFO - 'SHELL': '/bin/bash', 08:25:27 INFO - 'SHLVL': '1', 08:25:27 INFO - 'TERM': 'linux', 08:25:27 INFO - 'TMOUT': '86400', 08:25:27 INFO - 'USER': 'cltbld', 08:25:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756', 08:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:27 INFO - '_': '/tools/buildbot/bin/python'} 08:25:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 08:25:27 INFO - mozversion application_buildid: 20160428071449 08:25:27 INFO - mozversion application_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 08:25:27 INFO - mozversion application_display_name: Nightly 08:25:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:27 INFO - mozversion application_name: Firefox 08:25:27 INFO - mozversion application_remotingname: firefox 08:25:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:25:27 INFO - mozversion application_vendor: Mozilla 08:25:27 INFO - mozversion application_version: 49.0a1 08:25:27 INFO - mozversion platform_buildid: 20160428071449 08:25:27 INFO - mozversion platform_changeset: 53765e008b97622b5c7e26d22b2db016b0e53dc1 08:25:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:25:27 INFO - mozversion platform_version: 49.0a1 08:25:27 INFO - using testdate: 1461857127 08:25:27 INFO - actual date: 1461857127 08:25:27 INFO - starting webserver on 'localhost:55885' 08:25:27 INFO - SUITE-START | Running 2 tests 08:25:27 INFO - TEST-START | dromaeo_css 08:25:27 INFO - operating with platform_type : linux_ 08:25:27 INFO - Initialising browser for dromaeo_css test... 08:25:27 INFO - TEST-INFO | started process 13699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxeykx/profile http://localhost:55885/getInfo.html) 08:25:31 INFO - PROCESS | 13699 | __metrics Screen width/height:1600/1200 08:25:31 INFO - PROCESS | 13699 | colorDepth:24 08:25:31 INFO - PROCESS | 13699 | Browser inner width/height: 1024/697 08:25:31 INFO - PROCESS | 13699 | __metrics 08:25:32 ERROR - PROCESS | 13699 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:25:33 INFO - TEST-INFO | 13699: exit 0 08:25:33 INFO - Browser initialized. 08:25:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:33 INFO - TEST-INFO | started process 13781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxeykx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:45 INFO - PROCESS | 13781 | RSS: Main: 155987968 08:25:45 INFO - PROCESS | 13781 | 08:26:36 INFO - PROCESS | 13781 | 1461857196907 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] 08:28:48 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55885/tests/dromaeo/cssquery-ext.html) 08:28:49 INFO - PROCESS | 13781 | RSS: Main: 272252928 08:28:49 INFO - PROCESS | 13781 | 08:31:52 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-ext.html (next: http://localhost:55885/tests/dromaeo/cssquery-jquery.html) 08:31:52 INFO - PROCESS | 13781 | RSS: Main: 242008064 08:31:52 INFO - PROCESS | 13781 | 08:34:54 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55885/tests/dromaeo/cssquery-mootools.html) 08:34:55 INFO - PROCESS | 13781 | RSS: Main: 241639424 08:34:55 INFO - PROCESS | 13781 | 08:37:57 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55885/tests/dromaeo/cssquery-prototype.html) 08:37:58 INFO - PROCESS | 13781 | RSS: Main: 236003328 08:37:58 INFO - PROCESS | 13781 | 08:41:01 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55885/tests/dromaeo/cssquery-yui.html) 08:41:01 INFO - PROCESS | 13781 | RSS: Main: 214343680 08:41:01 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | Cycle 1(1): loaded http://localhost:55885/tests/dromaeo/cssquery-yui.html (next: http://localhost:55885/tests/dromaeo/cssquery-dojo.html) 08:44:04 INFO - PROCESS | 13781 | RSS: Main: 275693568 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | __start_tp_report 08:44:04 INFO - PROCESS | 13781 | _x_x_mozilla_page_load 08:44:04 INFO - PROCESS | 13781 | _x_x_mozilla_page_load_details 08:44:04 INFO - PROCESS | 13781 | |i|pagename|runs| 08:44:04 INFO - PROCESS | 13781 | |0;dojo.html;2598.2075466982574;2677.9196624101273;2679.035547203008;2689.865506724663;2718.035097540373;4427.0703152337965;4577.816887324511;4628.953710462899;4644.117617652643;4672.602828759555;4623.699459535128;4715.056988602285;4740.69185502942;4770.332153498513;4787.521247875211;4286.699931004831;4306.741595504272;4365.192439398706;4388.780560971939;4463.799129039201;4378.9562104378865;4409.933850992237;4418.668599855007;4428.225060614395;4451.532589078149;4203.327467605169;4284.592963668447;4284.935725964082;4369.235383807821;4378.715383500063;4286.142771445723;4323.113761678848;4328;4334.894601876533;4372.27857403528;4313.202057619319;4344.131173765228;4347.673924455678;4353.62994145498;4387.9907621246975;4471.217536931024;4535.546445355471;4570.72575645459;4635.142498637762;4653.441587009581;5019.899602007976;5037.924431133536;5043.722595257259;5047.949520504784;5083.771230294646;5050.9494905051215;5055.443901170868;5064.088464076464;5069.506915900859;5077.339945807022;4480.036792089716;4698.882527936829;4721.811127554894;4772.49888761682;4779.784909679072;5213.504717051874;5237.921431178459;5253.290805741176;5254.632175747661;5255.0540902637895;5032.798688052437;5043.747812609355;5044.495550445;5046.571041461443;5069.9746501267255;4896.216605343199;4956.950430495649;5000.424951130593;5029.547340739351;5051.646384753106;5007.974960125176;5044.697318160922;5054.848354549369;5055.949440505621;5097.8215762448135;4821.132196204647;5026.346574945233;5043.117454445531;5045.899082018413;5046.949530504648;4047.473828402348;4069.1658210066867;4138.875833724993;4148;4148.834046638161;3565.94651080234;3570.6786389225094;3576.910577235538;3614.6566076222716;3614.710823134143;4404.053128577371;4404.405405270311;4408.118376324748;4416.580424859633;4448.399466072039;4906.31311616374;5054.848354549369;5162.277281180638;5167.379914410295;5181.611379146579;4417.204903117406;4427.46870375557;4428.047969686469;4429.468463784367;4477.910441791146;4589.1051245007575;4596.747178905192;4598.816047358135;4599.701019433726;4645.558671926162;4698.765061746967;4796.928046079312;4845.1278769820365;4878.146324393288;4884.242942343943;5043.747812609428;5080.288759573737;5097.133487307093;5101.0818052750865;5144.254083157996;4703.882402939954;4816.927746083741;4841.661083724246;4859.246816743411;4913.508649135058;4919.2129259318335;4943.678660887031;4974.452810190804;4993.525615066563;5024.547790698854;5062.038212739568;5089.211172268304;5092.363454568179;5094.312267843794;5140.126178549581;4694.554017368481;4713.9057218856115;4930.359053323188;4942.555170034714;4990.750462476789;4868.050730107595;4891.339669144762;4898.583620392306;4908.361912951294;4940.431850337257;4791.904161916673;4794.760261986817;4800.35195248637;4831.855044348535;4893.632977526629;4692.178868698033;4878.756062196947;4938.209886418156;4966.577840883565;4971.776270067928;4690.437147542317;4757.643176761688;4796.904061918812;4803.567678908915;4828.348172996741 08:44:04 INFO - PROCESS | 13781 | |1;ext.html;559.6278474814249;585.3619554685389;598.117776279987;609.1289456077812;611.8623309755305;27295.863520682393;34143.14642133948;34561.48157777635;34675.306493870106;35166.472502912446;35207;35615.4657680135;35695.82152089236;35887.64112358882;35899.82050089746;7168.462365322595;7546.169921308651;7750.961245193766;7753.340966017895;7756.922430775677;9440.669576564822;9632.903670963306;9649.614015439409;9661.275404344668;9676.419414835133;9491.14579687828;9680.273979451535;9688.176504997049;9691.854622180674;9693.660721874736;9594.472304023277;9714.514274286257;9736.707898763048;9749.610015599332;9779.706608801676;9597.280203984728;9719.65981190662;9731;9736.464494452803;10013.89986100137;26039.609405858926;26524.602130967858;26565.601515977276;26597.468050639072;33110.83444582786;2834.7873909456666;2924.1666125154443;3021.0936718984217;3057.021753039028;3074.738647214989;28314.433711325863;28495.430091398055;29028.41943161146;29097;29456.8527157365;3160.683931606844;3193.4730769423018;3199.1202419334636;3201.295714942732;3250.089974807058;205788;207902;208707;208713.9999999985;209223;47780.28329575059;47855.5214447851;48185.5181448188;48230;48232.27651585229;56410.71794641083;56757;56804.43195568074;56805.147922781194;56867.715661421425;14364;14367.856321436651;14376.28118594087;14612.780808287884;14619.561413157622;11098.167637427225;11302.660920172408;11303.660890173143;11308.208425410307;11308.660740177807;17108.348206028084;17682.91158544199;18003.369882054067;18016.459506214833;18135.183916723516;6721.865562688817;6775.559588626724;6785.423239024738;6814.683007777379;7047.89428158578;955.603424578792;977.6138425321958;989.6536212325628;1022.6931920423843;1030.4229631406436;25427.61858572123;26884.193474195807;27451;28075.298117547223;28149.859250704027;965.3146266150972;968.162539403411;991.2070343724992;1000.3297790480395;1066.4507778494083;13684.589462316146;13711.451541938211;13952.372143253375;14057.507987220602;14299.499517516837;274572;278212;280315;280753;281309;46788.53211467842;47536.286955695694;47561.76219118882;47718.28422573664;47759.52240477551;1084.3927400655657;1240.9018019053203;1252.655519732081;1296.5786119511008;1323.4970711129902;24934;25841.741582583934;26506.204813855617;26553.203403897915;26568.468630626892;37118.8144059278;37882;37886.052848679006;37902.8104859474;37973.240535189696;191732;193072;193278;193352;194181;20572.279970200972;21164;23503.764962350157;24130.638040429058;24238.15166469165;36066.27867442689;36419.63580364268;37075;37241.25517489689;37425.25149497049;32039;32065.358692826478;32068.51897221497;32801.21189698902;33118.834405827816;31639.841800790848;31977.68022319747;32436.513452298706;32469.51295730613;32520.34959300848;33190.111712864;33846.830765847;34260.65739342575;34281.31437371189;34341.65658343385;28774;30847.38305233838;31256.843715781277;31263.53104703477;31371.68628313779;23768.286951391485;23809.64285535753;23900.28299151028;23903.402414939766;24213.515729684954 08:44:04 INFO - PROCESS | 13781 | |2;jquery.html;378.1057798307003;382.8495371408916;385.65483891916733;398.1559094719196;399.1398536154588;14799.556013319605;15726.370945162209;16089;16234;16252;14793.556193314218;15748.370065197378;16663.166841657898;16663.75004374932;16686.249118789652;4940.827071052505;5077.619178561604;5105.489451054902;5141.126008578532;5150.150225212836;3623.402138647133;5582.469665381782;5879.265091863517;5881.3530511643685;5881.500072493843;5577.079781835992;5821.922944255305;5827.475527202551;5841.269841269841;5844.211031510756;5625.268715067015;5764.51001664859;5768.942310576904;5770.942290577103;5777.1623114648355;3396.7961922284744;4775.856724298276;5188.948110518884;5198.064348417283;5198.974005129988;18255.0872456378;18741.156647950877;18857.339993100177;19132;19132.808671913383;1894.9242030318771;1950.7366505521716;2046.907889144992;2087.7285952826037;2575.137328994789;12114.394280285951;12263.69340766479;12495.187812792139;12540.557835848904;12598.307093109875;1764.4794785538297;1765.7263124215767;1770.4246120010919;1796.4161647464625;1895.895725735084;53980.19029714518;55899.44100558983;55948.16077758796;56016.43983560153;56730.43269567293;9009.324300677476;9160.175584197454;9372.67195648149;9660.420374777535;9987.900120998842;12208.75582488363;12284;12305.93847030759;12445.377731113407;12495.437705303284;7145.499815013003;7187.31720486553;7195.820104497429;7337.779866604011;7438.7024519019715;7020.824479388056;7023.719051237893;7052.118485189351;7084.893726594105;7119.501634885612;6097.451229389288;6130.1724267224245;6147.754089836357;6154.169187159766;6190.721417536221;1579.7472404415469;1702.7190513565124;1729.6281299520663;1767.4167524716813;1826.488583196707;876.8071024374627;885.5572213893054;909.8544232922701;978.8091322192247;995.2038369304528;15303.158326291938;16291.266892989845;16369.836301636831;16474.75287870683;16559.17204139788;834.7812194196541;881.9559022048871;931.3573634192386;936.4615346175976;963.0946909904667;8617.224449799549;8762.780930476789;8810.955945220232;8827.779305517413;9081.68214112503;375014;378446;387101;390006;392790;63980.68009659922;66880.33119668742;68309.3169068303;68362.31637683659;69496;920.8250432417954;935.3078721745995;942.1050002497655;956.550421301987;961.0149596663337;13576.93211533936;13688.45246190181;13728.313584320944;13748.65628359299;13785.379657915619;28394.85802570974;29606.259843504085;29958.203857952994;29976.550351744307;31043.37913241768;39607.40588891111;43616.56383436125;43670.34494482649;43855.78072109619;44112.77943610262;7434.219406962191;7612.80967975805;7618.390528757575;7645.961770191114;7683;10232.59069637206;10759.515821788194;10997.065249453886;11106.222564420414;11364.54541818318;9299.674511392339;9429.434233945985;9530.475823829756;9863.161631261137;9924.354916930377;9635.373700709431;9808.656697015856;9956.850647240153;10142.847857281999;10156.644517441853;9746.415215087118;9920.950395247977;10124.443155626512;10216.540255688364;10273.486325683836;7229.530080544958;7411.629418528944;7484.550926944401;7501.699932002659;7565.4325925556905;8704.477731336141;8858.468491890508;9013.639454422011;9158.816823663623;9404.482753448627 08:44:04 INFO - PROCESS | 13781 | |3;mootools.html;1234.3519652182597;1436.849130841262;1475.0264825215359;1548.7444571645678;1706.18103310411;6893.345132212438;7094.680739366728;7139.714411423537;7146.606936618484;7158.141023077225;6964.512484126113;7120.964395178017;7146.213916469184;7162.892556611655;7185.389241914443;1945.4260993007097;2187.5406164705432;2197.9890100549515;2234.0170325057006;2266.2294819761278;2231.1967691631;2246.865188088712;2249.0329158461855;2249.6288112461425;2252.5832720946596;2184.6673529147206;2192.451887028243;2232.598132336179;2233.251860626692;2235.1953296813135;1933.7776155742129;2122.172352782416;2165.6968024476587;2182.7598964113936;2183.4541364658835;2198.8240940724704;2203.1958335207696;2227.8440509164366;2228.186711850179;2229.888505574731;7158.534695244793;7182.03042589249;7225.421966242688;7234.782956511313;7255.564666119997;4451.399061126739;4583.0833833233155;4591.747453890035;4604.240300350438;4604.447466304032;2812.5640525718545;2815.07102656125;2886.5670149477537;2939.3680358722763;2953.069783018364;919.558611866308;947.4457442396207;963.4460185393357;978.8433850583872;985.1970643925179;9799.11807937289;9830.21358291335;9836.557354918974;9844.36011659247;9867.802643947152;4215.894602634898;4318.784060796947;4379.364992076131;4398.670099742532;4413.889652758707;8464.280536154372;8514.74455766328;8523.573821309034;8545.529995850287;8563.529005904611;4708.741019243975;4713.033828065239;4716.009637975995;4725.196716558194;4726.929096063562;3593.2633810069397;4143.233501802176;4252.829886804493;4253;4277.443932288783;3478.843452044664;3482.373172828915;3543.2204914918675;3562.821858907096;3565.1265439967374;1219.2440686774257;1222.394914517302;1248.1200753468784;1255.9560415385417;1260.886520213167;747.7009196321407;798.8522123407188;846.9745907622781;852.8720691896265;863.0334025890917;5106.565941894906;5323.467653234723;5328.333958255218;5346.957343318016;5404.540614047772;863.3165327611183;899.1727610598265;913.7213149989184;916.4272329793879;930.8417569013284;3458.9654103459147;3469.724369547511;3566.1619519412916;3588.928221435609;3597.748157628941;8519.95740021296;8924.241439477717;8949.373543851867;9050.728478145666;9088.363814532919;8850.867236991451;8942.195202431813;8952.283817294601;8961.955190224007;8973.192412682889;6769.323067693192;6889.758858439931;6958.65206739661;6971.755988540377;6977.581345119309;4932.4327702314695;5026.712845655145;5058.494150585059;5063.696178229318;5141.460146684544;8177.304929081095;8318.126596707501;8385.413021088465;8400.49597024156;8444.324454043539;8066.23370779775;8305.626246818787;8394.202550757913;8560.614772335384;8594.914050859412;5834.445727655866;5881.2942446906645;6043.697815109139;6101.664408457577;6242.126102345766;6796.830079248059;6809.114815074008;6881.174259088742;6888.0356750056035;6892.724291028303;6174.166487524307;6299.338569450325;6311.526635502264;6441.227052753699;6462.903056454251;6202.162708034358;6203.627782333075;6275.121482992476;6357.268914074755;6411.102445657519;6005.339412664516;6024.0662697282;6039.396060393926;6041.667708276087;6053.727582258721;4301.462317210348;4349.717268377545;4378.408914796461;4440.2007638625355;4495.730256184639;4316.956830431655;4391.5388884166705;4403.515613282472;4455.1535208310315;4464.464264288176 08:44:04 INFO - PROCESS | 13781 | |4;prototype.html;303.7236115135226;314.36184545372896;317.62044356993397;318.7370419403991;319.3325948767079;4487.798049087791;4567.725936443816;4606.792694328755;4688.413948256468;4731.526847315266;4523.570260825225;4641.491515257538;4671.672982891199;4687;4699.718016918987;3763.908466544699;3763.927280724994;3771.924561508768;3773.5660399054186;3784.0539865033743;3552.715782737375;3607.4228123500247;3743.7753734775865;3781.470594116826;3781.697464202857;3707.8702245421414;3708.332500149972;3709.7032237421076;3739.5325584301963;3740.8877733668032;3694.2980833641523;3696.593374728764;3704.2035962267973;3706.4810926470313;3733.405283328088;3322.335532893431;3333.3166700826273;3344.4983252512075;3353.815540145291;3374.9156271093175;4220.683448741326;4518;4521.728696278201;4523.457185137771;4533.342665313544;4119.155573107506;4124.546299907008;4125.64931980782;4145.440365550672;4156.43888075112;4824.2040063389495;4851.175300198975;4858.635602329804;4859.10106630271;4889.9511004889855;3302.653221411765;3493.877714279988;3505.526753888218;3523.2425028618713;3535.7524973251884;5036.7733451994745;5045.47022562633;5064.417591976933;5093.490650934914;5112.130937740556;3590.5691317042124;3597.794738762544;3598.838052287653;3599.3881040223223;3613.385724426854;3634.47300141478;3649.616790236987;3652.4886515887797;3654.214343916071;3665.0654083209142;3908.335582950905;4098.643280113946;4105.97947010263;4137.462129923151;4156;4859.125357435695;4865.9756701216975;4869.95130048695;4872.610191184696;4889.951100489021;1241.919275247124;1275.0883118570266;1301.4859130643533;1308.9934550327187;1319.4392383237087;892.6697122064877;898.3621628643606;910.6812615584493;914.3827916156567;920.8940971788196;4623.56076172763;4633.513481084505;4639;4645.488996210414;4646.070785842845;5291.100512912814;5295.470452954751;5308.177232528964;5316.76074576645;5331.600129990266;4482.125985432809;4595.655325850575;4601.7699115044115;4615.930761038587;4618.838340658061;2804.270889568686;2810.676772171186;2815.099168266176;2815.296175956011;2820.252633052243;5053.5957123430035;5074.4671809460215;5080.847574572768;5096.108181068298;5108.565771909355;5205.958808238367;5381.27352807366;5401.459854014645;5409.83770486886;5415.756290966916;5067.138586440314;5092.9236061459105;5095.847124586268;5099.4390617032095;5111.4921098276845;5305.257263982969;5311.601629877698;5313.442088580643;5316;5316.9468305318;4734.171519984058;5020.297158397901;5028.396592408934;5211.426743058185;5233.685978841282;4880.41435027799;4906.55840974314;4910.674117988195;4914.385701787277;4929.359183306291;3573.76770509916;3586.9820650896577;3596.6762991330907;3596.8021758803516;3597.28054389118;4811.580583727879;4822.8794280143275;5108.79564817418;5139.794408223629;5148.43367229612;4772.475027747015;4921.237208232729;4940.184869496493;4940.629452791127;4950.935548857013;4897.2654101885;4926.113299606105;4936.851894443173;4949.777260023236;4959.107360675113;4589.793459294273;4828.275758636092;4851.902961940671;4869.561739443467;4878.146324393288;4929.2359684248995;4947.703137811743;4959.652824302409;4980.750962451935;4980.975095124501;4823.807047718193;4848.17581011236;4866.1484240257105;4878.756062196805;4900.705957642553 08:44:04 INFO - PROCESS | 13781 | |5;yui.html;617.7992152550421;671.9798406047814;787.4920676163874;788.585992354014;793.0998316910305;12190.98848689965;12231.449584768685;12346.5061397544;12376.071794615395;12412.06909481789;12528.436220370082;12880.227186368824;12886.291253981028;12896.484140634364;12908.806367904488;642.3736856564858;787.8463699578584;813.8290958898639;823.0206054794805;829.7469271872077;819.1358117186365;824.085265355455;828.5525816059321;828.6354004238116;830.6552780596076;868.9261412779921;872.2193636695154;873.7422460374173;874.3966663002508;875.0461996423896;668.2815972829179;826.1614461321764;860.9698660546882;862.6894318045498;870.11683141611;626.7837596029362;627.3600927054379;627.7865525721231;629.3832044596321;631.6399652198248;12943.417546210349;12947.67630809228;12954.222746635232;13008.089433739642;13009.219446833125;11880;12344.691382715415;12420.378981051002;12515.874841251562;12532;9721.17370023549;9993.900060999369;9998.150157236643;10048.296619236657;10142.746431339276;4064.3700226464944;4067.410225517313;4105.4662893823615;4117.279476091702;4281.422008028907;44329.75837957535;44452.555474445166;45099;45680.54319456796;45931.999999999665;8986.326025548111;9059.501727405055;9192.540372981324;9212.35513514061;9256.259499240045;16812.24344904482;16878.578035548962;16889.15554222284;16919.661606767797;17291.221895014754;6711;6734.191896972395;6793.898091528631;6803.557768745016;6946.895796563055;3643.981780091083;3760.8871733848027;3784.262068896539;3869.3615553433933;3954.4661470701085;2818.8167769094944;2915.431490859262;2917.883284668632;2918.605988191567;2924.3420230448405;520.9817656382008;522.9607779416483;526.94730526947;532.6670830730793;538.4776766536531;478.7103802199689;562.6483447845097;617.9505639548826;625.3121566277059;666.2371584535776;8143.552104634184;8289.875651865226;8396;8545.2309292164;8786.209241168326;449.9955000450019;487.46378983118285;631.1416473595906;639.159505250594;646.7154452041087;3401.353742788912;3536.6286539913453;3574.767640103385;3611.7652352596997;3644.0514326172647;53313.73343133259;54136.45863541393;54215.186772198445;54286.728566357706;55080;47691.284630730566;47999;49555.50444495509;51407.22889156666;52247;42893.78553107277;42951.570484295386;46192.769036155274;46808;47772.522274776806;8077.353811695168;8332.666693332441;8611.440256383315;8668.869966950628;8789.780255493664;28061;29020;29981.70018299789;30199;30216.94240701565;37466.62533374631;37888.242235155696;39048.80475597604;39309.41035884521;39485.210295794495;10874.510647021061;11041.779164416826;11077.113830893348;11260.38067906273;11268.549258029587;10667;10763.300385474919;11840.585579504675;11961.880381196424;12037.578684745991;10343.689689309333;10561.313514621525;10646.254762166574;11019.283746556448;11025.558977641125;10786.191035672513;11053.171012173958;11215.439228038402;11223.66329010131;11949.761004779682;10345;10387.428691422045;10506.94746526293;10899.836502452312;11081.612143574936;8540.316774658137;8721.694740684046;8747.693830715894;8836.116388361112;8895.555222238992;9164.95417522908;9300.162985331353;9383.812323753351;9478.146966773023;9667.274954378308 08:44:04 INFO - PROCESS | 13781 | __end_tp_report 08:44:04 INFO - PROCESS | 13781 | __start_cc_report 08:44:04 INFO - PROCESS | 13781 | _x_x_mozilla_cycle_collect,1052 08:44:04 INFO - PROCESS | 13781 | __end_cc_report 08:44:04 INFO - PROCESS | 13781 | __startTimestamp1461858244869__endTimestamp 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | ------- Summary: start ------- 08:44:04 INFO - PROCESS | 13781 | Number of tests: 6 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#0] dojo.html Cycles:165 Average:4659.25 Median:4791.90 stddev:500.03 (10.4%) stddev-sans-first:474.70 08:44:04 INFO - PROCESS | 13781 | Values: 2598.2 2677.9 2679.0 2689.9 2718.0 4427.1 4577.8 4629.0 4644.1 4672.6 4623.7 4715.1 4740.7 4770.3 4787.5 4286.7 4306.7 4365.2 4388.8 4463.8 4379.0 4409.9 4418.7 4428.2 4451.5 4203.3 4284.6 4284.9 4369.2 4378.7 4286.1 4323.1 4328.0 4334.9 4372.3 4313.2 4344.1 4347.7 4353.6 4388.0 4471.2 4535.5 4570.7 4635.1 4653.4 5019.9 5037.9 5043.7 5047.9 5083.8 5050.9 5055.4 5064.1 5069.5 5077.3 4480.0 4698.9 4721.8 4772.5 4779.8 5213.5 5237.9 5253.3 5254.6 5255.1 5032.8 5043.7 5044.5 5046.6 5070.0 4896.2 4957.0 5000.4 5029.5 5051.6 5008.0 5044.7 5054.8 5055.9 5097.8 4821.1 5026.3 5043.1 5045.9 5046.9 4047.5 4069.2 4138.9 4148.0 4148.8 3565.9 3570.7 3576.9 3614.7 3614.7 4404.1 4404.4 4408.1 4416.6 4448.4 4906.3 5054.8 5162.3 5167.4 5181.6 4417.2 4427.5 4428.0 4429.5 4477.9 4589.1 4596.7 4598.8 4599.7 4645.6 4698.8 4796.9 4845.1 4878.1 4884.2 5043.7 5080.3 5097.1 5101.1 5144.3 4703.9 4816.9 4841.7 4859.2 4913.5 4919.2 4943.7 4974.5 4993.5 5024.5 5062.0 5089.2 5092.4 5094.3 5140.1 4694.6 4713.9 4930.4 4942.6 4990.8 4868.1 4891.3 4898.6 4908.4 4940.4 4791.9 4794.8 4800.4 4831.9 4893.6 4692.2 4878.8 4938.2 4966.6 4971.8 4690.4 4757.6 4796.9 4803.6 4828.3 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#1] ext.html Cycles:180 Average:38400.55 Median:17620.15 stddev:59789.40 (339.3%) stddev-sans-first:59889.61 08:44:04 INFO - PROCESS | 13781 | Values: 559.6 585.4 598.1 609.1 611.9 27295.9 34143.1 34561.5 34675.3 35166.5 35207.0 35615.5 35695.8 35887.6 35899.8 7168.5 7546.2 7751.0 7753.3 7756.9 9440.7 9632.9 9649.6 9661.3 9676.4 9491.1 9680.3 9688.2 9691.9 9693.7 9594.5 9714.5 9736.7 9749.6 9779.7 9597.3 9719.7 9731.0 9736.5 10013.9 26039.6 26524.6 26565.6 26597.5 33110.8 2834.8 2924.2 3021.1 3057.0 3074.7 28314.4 28495.4 29028.4 29097.0 29456.9 3160.7 3193.5 3199.1 3201.3 3250.1 205788.0 207902.0 208707.0 208714.0 209223.0 47780.3 47855.5 48185.5 48230.0 48232.3 56410.7 56757.0 56804.4 56805.1 56867.7 14364.0 14367.9 14376.3 14612.8 14619.6 11098.2 11302.7 11303.7 11308.2 11308.7 17108.3 17682.9 18003.4 18016.5 18135.2 6721.9 6775.6 6785.4 6814.7 7047.9 955.6 977.6 989.7 1022.7 1030.4 25427.6 26884.2 27451.0 28075.3 28149.9 965.3 968.2 991.2 1000.3 1066.5 13684.6 13711.5 13952.4 14057.5 14299.5 274572.0 278212.0 280315.0 280753.0 281309.0 46788.5 47536.3 47561.8 47718.3 47759.5 1084.4 1240.9 1252.7 1296.6 1323.5 24934.0 25841.7 26506.2 26553.2 26568.5 37118.8 37882.0 37886.1 37902.8 37973.2 191732.0 193072.0 193278.0 193352.0 194181.0 20572.3 21164.0 23503.8 24130.6 24238.2 36066.3 36419.6 37075.0 37241.3 37425.3 32039.0 32065.4 32068.5 32801.2 33118.8 31639.8 31977.7 32436.5 32469.5 32520.3 33190.1 33846.8 34260.7 34281.3 34341.7 28774.0 30847.4 31256.8 31263.5 31371.7 23768.3 23809.6 23900.3 23903.4 24213.5 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#2] jquery.html Cycles:180 Average:22910.76 Median:29589.58 stddev:63025.61 (213.0%) stddev-sans-first:63179.71 08:44:04 INFO - PROCESS | 13781 | Values: 378.1 382.8 385.7 398.2 399.1 14799.6 15726.4 16089.0 16234.0 16252.0 14793.6 15748.4 16663.2 16663.8 16686.2 4940.8 5077.6 5105.5 5141.1 5150.2 3623.4 5582.5 5879.3 5881.4 5881.5 5577.1 5821.9 5827.5 5841.3 5844.2 5625.3 5764.5 5768.9 5770.9 5777.2 3396.8 4775.9 5188.9 5198.1 5199.0 18255.1 18741.2 18857.3 19132.0 19132.8 1894.9 1950.7 2046.9 2087.7 2575.1 12114.4 12263.7 12495.2 12540.6 12598.3 1764.5 1765.7 1770.4 1796.4 1895.9 53980.2 55899.4 55948.2 56016.4 56730.4 9009.3 9160.2 9372.7 9660.4 9987.9 12208.8 12284.0 12305.9 12445.4 12495.4 7145.5 7187.3 7195.8 7337.8 7438.7 7020.8 7023.7 7052.1 7084.9 7119.5 6097.5 6130.2 6147.8 6154.2 6190.7 1579.7 1702.7 1729.6 1767.4 1826.5 876.8 885.6 909.9 978.8 995.2 15303.2 16291.3 16369.8 16474.8 16559.2 834.8 882.0 931.4 936.5 963.1 8617.2 8762.8 8811.0 8827.8 9081.7 375014.0 378446.0 387101.0 390006.0 392790.0 63980.7 66880.3 68309.3 68362.3 69496.0 920.8 935.3 942.1 956.6 961.0 13576.9 13688.5 13728.3 13748.7 13785.4 28394.9 29606.3 29958.2 29976.6 31043.4 39607.4 43616.6 43670.3 43855.8 44112.8 7434.2 7612.8 7618.4 7646.0 7683.0 10232.6 10759.5 10997.1 11106.2 11364.5 9299.7 9429.4 9530.5 9863.2 9924.4 9635.4 9808.7 9956.9 10142.8 10156.6 9746.4 9921.0 10124.4 10216.5 10273.5 7229.5 7411.6 7484.6 7501.7 7565.4 8704.5 8858.5 9013.6 9158.8 9404.5 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#3] mootools.html Cycles:180 Average:4888.51 Median:5857.87 stddev:2605.54 (44.5%) stddev-sans-first:2598.37 08:44:04 INFO - PROCESS | 13781 | Values: 1234.4 1436.8 1475.0 1548.7 1706.2 6893.3 7094.7 7139.7 7146.6 7158.1 6964.5 7121.0 7146.2 7162.9 7185.4 1945.4 2187.5 2198.0 2234.0 2266.2 2231.2 2246.9 2249.0 2249.6 2252.6 2184.7 2192.5 2232.6 2233.3 2235.2 1933.8 2122.2 2165.7 2182.8 2183.5 2198.8 2203.2 2227.8 2228.2 2229.9 7158.5 7182.0 7225.4 7234.8 7255.6 4451.4 4583.1 4591.7 4604.2 4604.4 2812.6 2815.1 2886.6 2939.4 2953.1 919.6 947.4 963.4 978.8 985.2 9799.1 9830.2 9836.6 9844.4 9867.8 4215.9 4318.8 4379.4 4398.7 4413.9 8464.3 8514.7 8523.6 8545.5 8563.5 4708.7 4713.0 4716.0 4725.2 4726.9 3593.3 4143.2 4252.8 4253.0 4277.4 3478.8 3482.4 3543.2 3562.8 3565.1 1219.2 1222.4 1248.1 1256.0 1260.9 747.7 798.9 847.0 852.9 863.0 5106.6 5323.5 5328.3 5347.0 5404.5 863.3 899.2 913.7 916.4 930.8 3459.0 3469.7 3566.2 3588.9 3597.7 8520.0 8924.2 8949.4 9050.7 9088.4 8850.9 8942.2 8952.3 8962.0 8973.2 6769.3 6889.8 6958.7 6971.8 6977.6 4932.4 5026.7 5058.5 5063.7 5141.5 8177.3 8318.1 8385.4 8400.5 8444.3 8066.2 8305.6 8394.2 8560.6 8594.9 5834.4 5881.3 6043.7 6101.7 6242.1 6796.8 6809.1 6881.2 6888.0 6892.7 6174.2 6299.3 6311.5 6441.2 6462.9 6202.2 6203.6 6275.1 6357.3 6411.1 6005.3 6024.1 6039.4 6041.7 6053.7 4301.5 4349.7 4378.4 4440.2 4495.7 4317.0 4391.5 4403.5 4455.2 4464.5 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#4] prototype.html Cycles:180 Average:4150.62 Median:4658.87 stddev:1201.77 (25.8%) stddev-sans-first:1169.94 08:44:04 INFO - PROCESS | 13781 | Values: 303.7 314.4 317.6 318.7 319.3 4487.8 4567.7 4606.8 4688.4 4731.5 4523.6 4641.5 4671.7 4687.0 4699.7 3763.9 3763.9 3771.9 3773.6 3784.1 3552.7 3607.4 3743.8 3781.5 3781.7 3707.9 3708.3 3709.7 3739.5 3740.9 3694.3 3696.6 3704.2 3706.5 3733.4 3322.3 3333.3 3344.5 3353.8 3374.9 4220.7 4518.0 4521.7 4523.5 4533.3 4119.2 4124.5 4125.6 4145.4 4156.4 4824.2 4851.2 4858.6 4859.1 4890.0 3302.7 3493.9 3505.5 3523.2 3535.8 5036.8 5045.5 5064.4 5093.5 5112.1 3590.6 3597.8 3598.8 3599.4 3613.4 3634.5 3649.6 3652.5 3654.2 3665.1 3908.3 4098.6 4106.0 4137.5 4156.0 4859.1 4866.0 4870.0 4872.6 4890.0 1241.9 1275.1 1301.5 1309.0 1319.4 892.7 898.4 910.7 914.4 920.9 4623.6 4633.5 4639.0 4645.5 4646.1 5291.1 5295.5 5308.2 5316.8 5331.6 4482.1 4595.7 4601.8 4615.9 4618.8 2804.3 2810.7 2815.1 2815.3 2820.3 5053.6 5074.5 5080.8 5096.1 5108.6 5206.0 5381.3 5401.5 5409.8 5415.8 5067.1 5092.9 5095.8 5099.4 5111.5 5305.3 5311.6 5313.4 5316.0 5316.9 4734.2 5020.3 5028.4 5211.4 5233.7 4880.4 4906.6 4910.7 4914.4 4929.4 3573.8 3587.0 3596.7 3596.8 3597.3 4811.6 4822.9 5108.8 5139.8 5148.4 4772.5 4921.2 4940.2 4940.6 4950.9 4897.3 4926.1 4936.9 4949.8 4959.1 4589.8 4828.3 4851.9 4869.6 4878.1 4929.2 4947.7 4959.7 4980.8 4981.0 4823.8 4848.2 4866.1 4878.8 4900.7 08:44:04 INFO - PROCESS | 13781 | 08:44:04 INFO - PROCESS | 13781 | [#5] yui.html Cycles:180 Average:12967.68 Median:46500.38 stddev:14903.92 (32.1%) stddev-sans-first:14916.88 08:44:04 INFO - PROCESS | 13781 | Values: 617.8 672.0 787.5 788.6 793.1 12191.0 12231.4 12346.5 12376.1 12412.1 12528.4 12880.2 12886.3 12896.5 12908.8 642.4 787.8 813.8 823.0 829.7 819.1 824.1 828.6 828.6 830.7 868.9 872.2 873.7 874.4 875.0 668.3 826.2 861.0 862.7 870.1 626.8 627.4 627.8 629.4 631.6 12943.4 12947.7 12954.2 13008.1 13009.2 11880.0 12344.7 12420.4 12515.9 12532.0 9721.2 9993.9 9998.2 10048.3 10142.7 4064.4 4067.4 4105.5 4117.3 4281.4 44329.8 44452.6 45099.0 45680.5 45932.0 8986.3 9059.5 9192.5 9212.4 9256.3 16812.2 16878.6 16889.2 16919.7 17291.2 6711.0 6734.2 6793.9 6803.6 6946.9 3644.0 3760.9 3784.3 3869.4 3954.5 2818.8 2915.4 2917.9 2918.6 2924.3 521.0 523.0 526.9 532.7 538.5 478.7 562.6 618.0 625.3 666.2 8143.6 8289.9 8396.0 8545.2 8786.2 450.0 487.5 631.1 639.2 646.7 3401.4 3536.6 3574.8 3611.8 3644.1 53313.7 54136.5 54215.2 54286.7 55080.0 47691.3 47999.0 49555.5 51407.2 52247.0 42893.8 42951.6 46192.8 46808.0 47772.5 8077.4 8332.7 8611.4 8668.9 8789.8 28061.0 29020.0 29981.7 30199.0 30216.9 37466.6 37888.2 39048.8 39309.4 39485.2 10874.5 11041.8 11077.1 11260.4 11268.5 10667.0 10763.3 11840.6 11961.9 12037.6 10343.7 10561.3 10646.3 11019.3 11025.6 10786.2 11053.2 11215.4 11223.7 11949.8 10345.0 10387.4 10506.9 10899.8 11081.6 8540.3 8721.7 8747.7 8836.1 8895.6 9165.0 9300.2 9383.8 9478.1 9667.3 08:44:04 INFO - PROCESS | 13781 | -------- Summary: end -------- 08:44:04 INFO - PROCESS | 13781 | 08:44:05 INFO - TEST-INFO | 13781: exit 0 08:44:05 INFO - TEST-OK | dromaeo_css | took 1118105ms 08:44:05 INFO - TEST-START | kraken 08:44:05 INFO - operating with platform_type : linux_ 08:44:05 INFO - Initialising browser for kraken test... 08:44:05 INFO - TEST-INFO | started process 13958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QHUL9/profile http://localhost:55885/getInfo.html) 08:44:09 INFO - PROCESS | 13958 | __metrics Screen width/height:1600/1200 08:44:09 INFO - PROCESS | 13958 | colorDepth:24 08:44:09 INFO - PROCESS | 13958 | Browser inner width/height: 1024/697 08:44:09 INFO - PROCESS | 13958 | __metrics 08:44:10 ERROR - PROCESS | 13958 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:44:11 INFO - TEST-INFO | 13958: exit 0 08:44:11 INFO - Browser initialized. 08:44:11 INFO - Running cycle 1/1 for kraken test... 08:44:11 INFO - TEST-INFO | started process 14040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QHUL9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:23 INFO - PROCESS | 14040 | RSS: Main: 156622848 08:44:23 INFO - PROCESS | 14040 | 08:44:26 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55885/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:27 INFO - PROCESS | 14040 | RSS: Main: 210612224 08:44:27 INFO - PROCESS | 14040 | 08:44:29 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55885/tests/kraken/driver.html?testName=audio-dft) 08:44:30 INFO - PROCESS | 14040 | RSS: Main: 197144576 08:44:30 INFO - PROCESS | 14040 | 08:44:33 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55885/tests/kraken/driver.html?testName=audio-fft) 08:44:34 INFO - PROCESS | 14040 | RSS: Main: 267538432 08:44:34 INFO - PROCESS | 14040 | 08:44:36 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55885/tests/kraken/driver.html?testName=audio-oscillator) 08:44:37 INFO - PROCESS | 14040 | RSS: Main: 175898624 08:44:37 INFO - PROCESS | 14040 | 08:44:39 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:39 INFO - PROCESS | 14040 | RSS: Main: 179597312 08:44:39 INFO - PROCESS | 14040 | 08:44:43 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55885/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:43 INFO - PROCESS | 14040 | RSS: Main: 216502272 08:44:43 INFO - PROCESS | 14040 | 08:44:47 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55885/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:47 INFO - PROCESS | 14040 | RSS: Main: 214011904 08:44:47 INFO - PROCESS | 14040 | 08:44:50 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55885/tests/kraken/driver.html?testName=json-parse-financial) 08:44:51 INFO - PROCESS | 14040 | RSS: Main: 215027712 08:44:51 INFO - PROCESS | 14040 | 08:44:52 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:53 INFO - PROCESS | 14040 | RSS: Main: 204029952 08:44:53 INFO - PROCESS | 14040 | 08:44:55 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:56 INFO - PROCESS | 14040 | RSS: Main: 204963840 08:44:56 INFO - PROCESS | 14040 | 08:44:58 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:58 INFO - PROCESS | 14040 | RSS: Main: 218296320 08:44:58 INFO - PROCESS | 14040 | 08:45:01 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:02 INFO - PROCESS | 14040 | RSS: Main: 224329728 08:45:02 INFO - PROCESS | 14040 | 08:45:05 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:06 INFO - PROCESS | 14040 | RSS: Main: 219947008 08:45:06 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | Cycle 1(1): loaded http://localhost:55885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55885/tests/kraken/driver.html?testName=ai-astar) 08:45:08 INFO - PROCESS | 14040 | RSS: Main: 283701248 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | __start_tp_report 08:45:08 INFO - PROCESS | 14040 | _x_x_mozilla_page_load 08:45:08 INFO - PROCESS | 14040 | _x_x_mozilla_page_load_details 08:45:08 INFO - PROCESS | 14040 | |i|pagename|runs| 08:45:08 INFO - PROCESS | 14040 | |0;ai-astar;111;114;108;112;114;116;101;112;114;111 08:45:08 INFO - PROCESS | 14040 | |1;audio-beat-detection;167;131;160;184;135;160;153;133;193;132 08:45:08 INFO - PROCESS | 14040 | |2;audio-dft;161;160;160;161;161;159;163;163;162;160 08:45:08 INFO - PROCESS | 14040 | |3;audio-fft;75;78;100;106;77;79;73;115;102;77 08:45:08 INFO - PROCESS | 14040 | |4;audio-oscillator;95;100;149;94;95;94;146;94;102;137 08:45:08 INFO - PROCESS | 14040 | |5;imaging-gaussian-blur;117;117;116;116;117;117;116;116;117;117 08:45:08 INFO - PROCESS | 14040 | |6;imaging-darkroom;147;147;147;147;146;149;146;146;147;149 08:45:08 INFO - PROCESS | 14040 | |7;imaging-desaturate;97;94;95;96;95;95;95;95;95;95 08:45:08 INFO - PROCESS | 14040 | |8;json-parse-financial;64;64;64;63;64;63;64;80;62;61 08:45:08 INFO - PROCESS | 14040 | |9;json-stringify-tinderbox;65;64;66;65;65;64;64;65;65;65 08:45:08 INFO - PROCESS | 14040 | |10;stanford-crypto-aes;79;89;81;79;80;79;80;88;79;81 08:45:08 INFO - PROCESS | 14040 | |11;stanford-crypto-ccm;135;137;132;135;140;132;132;133;179;135 08:45:08 INFO - PROCESS | 14040 | |12;stanford-crypto-pbkdf2;219;213;217;220;214;214;214;216;211;218 08:45:08 INFO - PROCESS | 14040 | |13;stanford-crypto-sha256-iterative;84;76;75;74;74;75;73;73;75;74 08:45:08 INFO - PROCESS | 14040 | __end_tp_report 08:45:08 INFO - PROCESS | 14040 | __start_cc_report 08:45:08 INFO - PROCESS | 14040 | _x_x_mozilla_cycle_collect,1913 08:45:08 INFO - PROCESS | 14040 | __end_cc_report 08:45:08 INFO - PROCESS | 14040 | __startTimestamp1461858308306__endTimestamp 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | ------- Summary: start ------- 08:45:08 INFO - PROCESS | 14040 | Number of tests: 14 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.24 (3.8%) stddev-sans-first:4.50 08:45:08 INFO - PROCESS | 14040 | Values: 111.0 114.0 108.0 112.0 114.0 116.0 101.0 112.0 114.0 111.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:160.00 stddev:22.29 (13.9%) stddev-sans-first:23.20 08:45:08 INFO - PROCESS | 14040 | Values: 167.0 131.0 160.0 184.0 135.0 160.0 153.0 133.0 193.0 132.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 08:45:08 INFO - PROCESS | 14040 | Values: 161.0 160.0 160.0 161.0 161.0 159.0 163.0 163.0 162.0 160.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#3] audio-fft Cycles:10 Average:88.20 Median:76.00 stddev:15.67 (20.6%) stddev-sans-first:15.87 08:45:08 INFO - PROCESS | 14040 | Values: 75.0 78.0 100.0 106.0 77.0 79.0 73.0 115.0 102.0 77.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:23.39 (24.9%) stddev-sans-first:24.12 08:45:08 INFO - PROCESS | 14040 | Values: 95.0 100.0 149.0 94.0 95.0 94.0 146.0 94.0 102.0 137.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:45:08 INFO - PROCESS | 14040 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:45:08 INFO - PROCESS | 14040 | Values: 147.0 147.0 147.0 147.0 146.0 149.0 146.0 146.0 147.0 149.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 08:45:08 INFO - PROCESS | 14040 | Values: 97.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.00 stddev:5.40 (8.4%) stddev-sans-first:5.72 08:45:08 INFO - PROCESS | 14040 | Values: 64.0 64.0 64.0 63.0 64.0 63.0 64.0 80.0 62.0 61.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 08:45:08 INFO - PROCESS | 14040 | Values: 65.0 64.0 66.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.50 stddev:3.78 (4.7%) stddev-sans-first:3.90 08:45:08 INFO - PROCESS | 14040 | Values: 79.0 89.0 81.0 79.0 80.0 79.0 80.0 88.0 79.0 81.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.00 stddev:14.28 (10.6%) stddev-sans-first:15.08 08:45:08 INFO - PROCESS | 14040 | Values: 135.0 137.0 132.0 135.0 140.0 132.0 132.0 133.0 179.0 135.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.60 Median:216.50 stddev:2.88 (1.3%) stddev-sans-first:2.77 08:45:08 INFO - PROCESS | 14040 | Values: 219.0 213.0 217.0 220.0 214.0 214.0 214.0 216.0 211.0 218.0 08:45:08 INFO - PROCESS | 14040 | 08:45:08 INFO - PROCESS | 14040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.00 stddev:3.20 (4.3%) stddev-sans-first:1.00 08:45:08 INFO - PROCESS | 14040 | Values: 84.0 76.0 75.0 74.0 74.0 75.0 73.0 73.0 75.0 74.0 08:45:08 INFO - PROCESS | 14040 | -------- Summary: end -------- 08:45:08 INFO - PROCESS | 14040 | 08:45:09 INFO - TEST-INFO | 14040: exit 0 08:45:09 INFO - TEST-OK | kraken | took 63805ms 08:45:09 INFO - SUITE-END | took 1181s 08:45:09 INFO - Completed test suite (00:19:41) 08:45:09 INFO - javascript benchmark 08:45:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.2075466982574, 2677.9196624101273, 2679.035547203008, 2689.865506724663, 2718.035097540373, 4427.0703152337965, 4577.816887324511, 4628.953710462899, 4644.117617652643, 4672.602828759555, 4623.699459535128, 4715.056988602285, 4740.69185502942, 4770.332153498513, 4787.521247875211, 4286.699931004831, 4306.741595504272, 4365.192439398706, 4388.780560971939, 4463.799129039201, 4378.9562104378865, 4409.933850992237, 4418.668599855007, 4428.225060614395, 4451.532589078149, 4203.327467605169, 4284.592963668447, 4284.935725964082, 4369.235383807821, 4378.715383500063, 4286.142771445723, 4323.113761678848, 4328.0, 4334.894601876533, 4372.27857403528, 4313.202057619319, 4344.131173765228, 4347.673924455678, 4353.62994145498, 4387.9907621246975, 4471.217536931024, 4535.546445355471, 4570.72575645459, 4635.142498637762, 4653.441587009581, 5019.899602007976, 5037.924431133536, 5043.722595257259, 5047.949520504784, 5083.771230294646, 5050.9494905051215, 5055.443901170868, 5064.088464076464, 5069.506915900859, 5077.339945807022, 4480.036792089716, 4698.882527936829, 4721.811127554894, 4772.49888761682, 4779.784909679072, 5213.504717051874, 5237.921431178459, 5253.290805741176, 5254.632175747661, 5255.0540902637895, 5032.798688052437, 5043.747812609355, 5044.495550445, 5046.571041461443, 5069.9746501267255, 4896.216605343199, 4956.950430495649, 5000.424951130593, 5029.547340739351, 5051.646384753106, 5007.974960125176, 5044.697318160922, 5054.848354549369, 5055.949440505621, 5097.8215762448135, 4821.132196204647, 5026.346574945233, 5043.117454445531, 5045.899082018413, 5046.949530504648, 4047.473828402348, 4069.1658210066867, 4138.875833724993, 4148.0, 4148.834046638161, 3565.94651080234, 3570.6786389225094, 3576.910577235538, 3614.6566076222716, 3614.710823134143, 4404.053128577371, 4404.405405270311, 4408.118376324748, 4416.580424859633, 4448.399466072039, 4906.31311616374, 5054.848354549369, 5162.277281180638, 5167.379914410295, 5181.611379146579, 4417.204903117406, 4427.46870375557, 4428.047969686469, 4429.468463784367, 4477.910441791146, 4589.1051245007575, 4596.747178905192, 4598.816047358135, 4599.701019433726, 4645.558671926162, 4698.765061746967, 4796.928046079312, 4845.1278769820365, 4878.146324393288, 4884.242942343943, 5043.747812609428, 5080.288759573737, 5097.133487307093, 5101.0818052750865, 5144.254083157996, 4703.882402939954, 4816.927746083741, 4841.661083724246, 4859.246816743411, 4913.508649135058, 4919.2129259318335, 4943.678660887031, 4974.452810190804, 4993.525615066563, 5024.547790698854, 5062.038212739568, 5089.211172268304, 5092.363454568179, 5094.312267843794, 5140.126178549581, 4694.554017368481, 4713.9057218856115, 4930.359053323188, 4942.555170034714, 4990.750462476789, 4868.050730107595, 4891.339669144762, 4898.583620392306, 4908.361912951294, 4940.431850337257, 4791.904161916673, 4794.760261986817, 4800.35195248637, 4831.855044348535, 4893.632977526629, 4692.178868698033, 4878.756062196947, 4938.209886418156, 4966.577840883565, 4971.776270067928, 4690.437147542317, 4757.643176761688, 4796.904061918812, 4803.567678908915, 4828.348172996741], "value": 4627.12102036541, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6278474814249, 585.3619554685389, 598.117776279987, 609.1289456077812, 611.8623309755305, 27295.863520682393, 34143.14642133948, 34561.48157777635, 34675.306493870106, 35166.472502912446, 35207.0, 35615.4657680135, 35695.82152089236, 35887.64112358882, 35899.82050089746, 7168.462365322595, 7546.169921308651, 7750.961245193766, 7753.340966017895, 7756.922430775677, 9440.669576564822, 9632.903670963306, 9649.614015439409, 9661.275404344668, 9676.419414835133, 9491.14579687828, 9680.273979451535, 9688.176504997049, 9691.854622180674, 9693.660721874736, 9594.472304023277, 9714.514274286257, 9736.707898763048, 9749.610015599332, 9779.706608801676, 9597.280203984728, 9719.65981190662, 9731.0, 9736.464494452803, 10013.89986100137, 26039.609405858926, 26524.602130967858, 26565.601515977276, 26597.468050639072, 33110.83444582786, 2834.7873909456666, 2924.1666125154443, 3021.0936718984217, 3057.021753039028, 3074.738647214989, 28314.433711325863, 28495.430091398055, 29028.41943161146, 29097.0, 29456.8527157365, 3160.683931606844, 3193.4730769423018, 3199.1202419334636, 3201.295714942732, 3250.089974807058, 205788.0, 207902.0, 208707.0, 208713.9999999985, 209223.0, 47780.28329575059, 47855.5214447851, 48185.5181448188, 48230.0, 48232.27651585229, 56410.71794641083, 56757.0, 56804.43195568074, 56805.147922781194, 56867.715661421425, 14364.0, 14367.856321436651, 14376.28118594087, 14612.780808287884, 14619.561413157622, 11098.167637427225, 11302.660920172408, 11303.660890173143, 11308.208425410307, 11308.660740177807, 17108.348206028084, 17682.91158544199, 18003.369882054067, 18016.459506214833, 18135.183916723516, 6721.865562688817, 6775.559588626724, 6785.423239024738, 6814.683007777379, 7047.89428158578, 955.603424578792, 977.6138425321958, 989.6536212325628, 1022.6931920423843, 1030.4229631406436, 25427.61858572123, 26884.193474195807, 27451.0, 28075.298117547223, 28149.859250704027, 965.3146266150972, 968.162539403411, 991.2070343724992, 1000.3297790480395, 1066.4507778494083, 13684.589462316146, 13711.451541938211, 13952.372143253375, 14057.507987220602, 14299.499517516837, 274572.0, 278212.0, 280315.0, 280753.0, 281309.0, 46788.53211467842, 47536.286955695694, 47561.76219118882, 47718.28422573664, 47759.52240477551, 1084.3927400655657, 1240.9018019053203, 1252.655519732081, 1296.5786119511008, 1323.4970711129902, 24934.0, 25841.741582583934, 26506.204813855617, 26553.203403897915, 26568.468630626892, 37118.8144059278, 37882.0, 37886.052848679006, 37902.8104859474, 37973.240535189696, 191732.0, 193072.0, 193278.0, 193352.0, 194181.0, 20572.279970200972, 21164.0, 23503.764962350157, 24130.638040429058, 24238.15166469165, 36066.27867442689, 36419.63580364268, 37075.0, 37241.25517489689, 37425.25149497049, 32039.0, 32065.358692826478, 32068.51897221497, 32801.21189698902, 33118.834405827816, 31639.841800790848, 31977.68022319747, 32436.513452298706, 32469.51295730613, 32520.34959300848, 33190.111712864, 33846.830765847, 34260.65739342575, 34281.31437371189, 34341.65658343385, 28774.0, 30847.38305233838, 31256.843715781277, 31263.53104703477, 31371.68628313779, 23768.286951391485, 23809.64285535753, 23900.28299151028, 23903.402414939766, 24213.515729684954], "value": 16698.229054472242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1057798307003, 382.8495371408916, 385.65483891916733, 398.1559094719196, 399.1398536154588, 14799.556013319605, 15726.370945162209, 16089.0, 16234.0, 16252.0, 14793.556193314218, 15748.370065197378, 16663.166841657898, 16663.75004374932, 16686.249118789652, 4940.827071052505, 5077.619178561604, 5105.489451054902, 5141.126008578532, 5150.150225212836, 3623.402138647133, 5582.469665381782, 5879.265091863517, 5881.3530511643685, 5881.500072493843, 5577.079781835992, 5821.922944255305, 5827.475527202551, 5841.269841269841, 5844.211031510756, 5625.268715067015, 5764.51001664859, 5768.942310576904, 5770.942290577103, 5777.1623114648355, 3396.7961922284744, 4775.856724298276, 5188.948110518884, 5198.064348417283, 5198.974005129988, 18255.0872456378, 18741.156647950877, 18857.339993100177, 19132.0, 19132.808671913383, 1894.9242030318771, 1950.7366505521716, 2046.907889144992, 2087.7285952826037, 2575.137328994789, 12114.394280285951, 12263.69340766479, 12495.187812792139, 12540.557835848904, 12598.307093109875, 1764.4794785538297, 1765.7263124215767, 1770.4246120010919, 1796.4161647464625, 1895.895725735084, 53980.19029714518, 55899.44100558983, 55948.16077758796, 56016.43983560153, 56730.43269567293, 9009.324300677476, 9160.175584197454, 9372.67195648149, 9660.420374777535, 9987.900120998842, 12208.75582488363, 12284.0, 12305.93847030759, 12445.377731113407, 12495.437705303284, 7145.499815013003, 7187.31720486553, 7195.820104497429, 7337.779866604011, 7438.7024519019715, 7020.824479388056, 7023.719051237893, 7052.118485189351, 7084.893726594105, 7119.501634885612, 6097.451229389288, 6130.1724267224245, 6147.754089836357, 6154.169187159766, 6190.721417536221, 1579.7472404415469, 1702.7190513565124, 1729.6281299520663, 1767.4167524716813, 1826.488583196707, 876.8071024374627, 885.5572213893054, 909.8544232922701, 978.8091322192247, 995.2038369304528, 15303.158326291938, 16291.266892989845, 16369.836301636831, 16474.75287870683, 16559.17204139788, 834.7812194196541, 881.9559022048871, 931.3573634192386, 936.4615346175976, 963.0946909904667, 8617.224449799549, 8762.780930476789, 8810.955945220232, 8827.779305517413, 9081.68214112503, 375014.0, 378446.0, 387101.0, 390006.0, 392790.0, 63980.68009659922, 66880.33119668742, 68309.3169068303, 68362.31637683659, 69496.0, 920.8250432417954, 935.3078721745995, 942.1050002497655, 956.550421301987, 961.0149596663337, 13576.93211533936, 13688.45246190181, 13728.313584320944, 13748.65628359299, 13785.379657915619, 28394.85802570974, 29606.259843504085, 29958.203857952994, 29976.550351744307, 31043.37913241768, 39607.40588891111, 43616.56383436125, 43670.34494482649, 43855.78072109619, 44112.77943610262, 7434.219406962191, 7612.80967975805, 7618.390528757575, 7645.961770191114, 7683.0, 10232.59069637206, 10759.515821788194, 10997.065249453886, 11106.222564420414, 11364.54541818318, 9299.674511392339, 9429.434233945985, 9530.475823829756, 9863.161631261137, 9924.354916930377, 9635.373700709431, 9808.656697015856, 9956.850647240153, 10142.847857281999, 10156.644517441853, 9746.415215087118, 9920.950395247977, 10124.443155626512, 10216.540255688364, 10273.486325683836, 7229.530080544958, 7411.629418528944, 7484.550926944401, 7501.699932002659, 7565.4325925556905, 8704.477731336141, 8858.468491890508, 9013.639454422011, 9158.816823663623, 9404.482753448627], "value": 8029.525645098515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.3519652182597, 1436.849130841262, 1475.0264825215359, 1548.7444571645678, 1706.18103310411, 6893.345132212438, 7094.680739366728, 7139.714411423537, 7146.606936618484, 7158.141023077225, 6964.512484126113, 7120.964395178017, 7146.213916469184, 7162.892556611655, 7185.389241914443, 1945.4260993007097, 2187.5406164705432, 2197.9890100549515, 2234.0170325057006, 2266.2294819761278, 2231.1967691631, 2246.865188088712, 2249.0329158461855, 2249.6288112461425, 2252.5832720946596, 2184.6673529147206, 2192.451887028243, 2232.598132336179, 2233.251860626692, 2235.1953296813135, 1933.7776155742129, 2122.172352782416, 2165.6968024476587, 2182.7598964113936, 2183.4541364658835, 2198.8240940724704, 2203.1958335207696, 2227.8440509164366, 2228.186711850179, 2229.888505574731, 7158.534695244793, 7182.03042589249, 7225.421966242688, 7234.782956511313, 7255.564666119997, 4451.399061126739, 4583.0833833233155, 4591.747453890035, 4604.240300350438, 4604.447466304032, 2812.5640525718545, 2815.07102656125, 2886.5670149477537, 2939.3680358722763, 2953.069783018364, 919.558611866308, 947.4457442396207, 963.4460185393357, 978.8433850583872, 985.1970643925179, 9799.11807937289, 9830.21358291335, 9836.557354918974, 9844.36011659247, 9867.802643947152, 4215.894602634898, 4318.784060796947, 4379.364992076131, 4398.670099742532, 4413.889652758707, 8464.280536154372, 8514.74455766328, 8523.573821309034, 8545.529995850287, 8563.529005904611, 4708.741019243975, 4713.033828065239, 4716.009637975995, 4725.196716558194, 4726.929096063562, 3593.2633810069397, 4143.233501802176, 4252.829886804493, 4253.0, 4277.443932288783, 3478.843452044664, 3482.373172828915, 3543.2204914918675, 3562.821858907096, 3565.1265439967374, 1219.2440686774257, 1222.394914517302, 1248.1200753468784, 1255.9560415385417, 1260.886520213167, 747.7009196321407, 798.8522123407188, 846.9745907622781, 852.8720691896265, 863.0334025890917, 5106.565941894906, 5323.467653234723, 5328.333958255218, 5346.957343318016, 5404.540614047772, 863.3165327611183, 899.1727610598265, 913.7213149989184, 916.4272329793879, 930.8417569013284, 3458.9654103459147, 3469.724369547511, 3566.1619519412916, 3588.928221435609, 3597.748157628941, 8519.95740021296, 8924.241439477717, 8949.373543851867, 9050.728478145666, 9088.363814532919, 8850.867236991451, 8942.195202431813, 8952.283817294601, 8961.955190224007, 8973.192412682889, 6769.323067693192, 6889.758858439931, 6958.65206739661, 6971.755988540377, 6977.581345119309, 4932.4327702314695, 5026.712845655145, 5058.494150585059, 5063.696178229318, 5141.460146684544, 8177.304929081095, 8318.126596707501, 8385.413021088465, 8400.49597024156, 8444.324454043539, 8066.23370779775, 8305.626246818787, 8394.202550757913, 8560.614772335384, 8594.914050859412, 5834.445727655866, 5881.2942446906645, 6043.697815109139, 6101.664408457577, 6242.126102345766, 6796.830079248059, 6809.114815074008, 6881.174259088742, 6888.0356750056035, 6892.724291028303, 6174.166487524307, 6299.338569450325, 6311.526635502264, 6441.227052753699, 6462.903056454251, 6202.162708034358, 6203.627782333075, 6275.121482992476, 6357.268914074755, 6411.102445657519, 6005.339412664516, 6024.0662697282, 6039.396060393926, 6041.667708276087, 6053.727582258721, 4301.462317210348, 4349.717268377545, 4378.408914796461, 4440.2007638625355, 4495.730256184639, 4316.956830431655, 4391.5388884166705, 4403.515613282472, 4455.1535208310315, 4464.464264288176], "value": 4017.704146684651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7236115135226, 314.36184545372896, 317.62044356993397, 318.7370419403991, 319.3325948767079, 4487.798049087791, 4567.725936443816, 4606.792694328755, 4688.413948256468, 4731.526847315266, 4523.570260825225, 4641.491515257538, 4671.672982891199, 4687.0, 4699.718016918987, 3763.908466544699, 3763.927280724994, 3771.924561508768, 3773.5660399054186, 3784.0539865033743, 3552.715782737375, 3607.4228123500247, 3743.7753734775865, 3781.470594116826, 3781.697464202857, 3707.8702245421414, 3708.332500149972, 3709.7032237421076, 3739.5325584301963, 3740.8877733668032, 3694.2980833641523, 3696.593374728764, 3704.2035962267973, 3706.4810926470313, 3733.405283328088, 3322.335532893431, 3333.3166700826273, 3344.4983252512075, 3353.815540145291, 3374.9156271093175, 4220.683448741326, 4518.0, 4521.728696278201, 4523.457185137771, 4533.342665313544, 4119.155573107506, 4124.546299907008, 4125.64931980782, 4145.440365550672, 4156.43888075112, 4824.2040063389495, 4851.175300198975, 4858.635602329804, 4859.10106630271, 4889.9511004889855, 3302.653221411765, 3493.877714279988, 3505.526753888218, 3523.2425028618713, 3535.7524973251884, 5036.7733451994745, 5045.47022562633, 5064.417591976933, 5093.490650934914, 5112.130937740556, 3590.5691317042124, 3597.794738762544, 3598.838052287653, 3599.3881040223223, 3613.385724426854, 3634.47300141478, 3649.616790236987, 3652.4886515887797, 3654.214343916071, 3665.0654083209142, 3908.335582950905, 4098.643280113946, 4105.97947010263, 4137.462129923151, 4156.0, 4859.125357435695, 4865.9756701216975, 4869.95130048695, 4872.610191184696, 4889.951100489021, 1241.919275247124, 1275.0883118570266, 1301.4859130643533, 1308.9934550327187, 1319.4392383237087, 892.6697122064877, 898.3621628643606, 910.6812615584493, 914.3827916156567, 920.8940971788196, 4623.56076172763, 4633.513481084505, 4639.0, 4645.488996210414, 4646.070785842845, 5291.100512912814, 5295.470452954751, 5308.177232528964, 5316.76074576645, 5331.600129990266, 4482.125985432809, 4595.655325850575, 4601.7699115044115, 4615.930761038587, 4618.838340658061, 2804.270889568686, 2810.676772171186, 2815.099168266176, 2815.296175956011, 2820.252633052243, 5053.5957123430035, 5074.4671809460215, 5080.847574572768, 5096.108181068298, 5108.565771909355, 5205.958808238367, 5381.27352807366, 5401.459854014645, 5409.83770486886, 5415.756290966916, 5067.138586440314, 5092.9236061459105, 5095.847124586268, 5099.4390617032095, 5111.4921098276845, 5305.257263982969, 5311.601629877698, 5313.442088580643, 5316.0, 5316.9468305318, 4734.171519984058, 5020.297158397901, 5028.396592408934, 5211.426743058185, 5233.685978841282, 4880.41435027799, 4906.55840974314, 4910.674117988195, 4914.385701787277, 4929.359183306291, 3573.76770509916, 3586.9820650896577, 3596.6762991330907, 3596.8021758803516, 3597.28054389118, 4811.580583727879, 4822.8794280143275, 5108.79564817418, 5139.794408223629, 5148.43367229612, 4772.475027747015, 4921.237208232729, 4940.184869496493, 4940.629452791127, 4950.935548857013, 4897.2654101885, 4926.113299606105, 4936.851894443173, 4949.777260023236, 4959.107360675113, 4589.793459294273, 4828.275758636092, 4851.902961940671, 4869.561739443467, 4878.146324393288, 4929.2359684248995, 4947.703137811743, 4959.652824302409, 4980.750962451935, 4980.975095124501, 4823.807047718193, 4848.17581011236, 4866.1484240257105, 4878.756062196805, 4900.705957642553], "value": 3779.554916347559, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.7992152550421, 671.9798406047814, 787.4920676163874, 788.585992354014, 793.0998316910305, 12190.98848689965, 12231.449584768685, 12346.5061397544, 12376.071794615395, 12412.06909481789, 12528.436220370082, 12880.227186368824, 12886.291253981028, 12896.484140634364, 12908.806367904488, 642.3736856564858, 787.8463699578584, 813.8290958898639, 823.0206054794805, 829.7469271872077, 819.1358117186365, 824.085265355455, 828.5525816059321, 828.6354004238116, 830.6552780596076, 868.9261412779921, 872.2193636695154, 873.7422460374173, 874.3966663002508, 875.0461996423896, 668.2815972829179, 826.1614461321764, 860.9698660546882, 862.6894318045498, 870.11683141611, 626.7837596029362, 627.3600927054379, 627.7865525721231, 629.3832044596321, 631.6399652198248, 12943.417546210349, 12947.67630809228, 12954.222746635232, 13008.089433739642, 13009.219446833125, 11880.0, 12344.691382715415, 12420.378981051002, 12515.874841251562, 12532.0, 9721.17370023549, 9993.900060999369, 9998.150157236643, 10048.296619236657, 10142.746431339276, 4064.3700226464944, 4067.410225517313, 4105.4662893823615, 4117.279476091702, 4281.422008028907, 44329.75837957535, 44452.555474445166, 45099.0, 45680.54319456796, 45931.999999999665, 8986.326025548111, 9059.501727405055, 9192.540372981324, 9212.35513514061, 9256.259499240045, 16812.24344904482, 16878.578035548962, 16889.15554222284, 16919.661606767797, 17291.221895014754, 6711.0, 6734.191896972395, 6793.898091528631, 6803.557768745016, 6946.895796563055, 3643.981780091083, 3760.8871733848027, 3784.262068896539, 3869.3615553433933, 3954.4661470701085, 2818.8167769094944, 2915.431490859262, 2917.883284668632, 2918.605988191567, 2924.3420230448405, 520.9817656382008, 522.9607779416483, 526.94730526947, 532.6670830730793, 538.4776766536531, 478.7103802199689, 562.6483447845097, 617.9505639548826, 625.3121566277059, 666.2371584535776, 8143.552104634184, 8289.875651865226, 8396.0, 8545.2309292164, 8786.209241168326, 449.9955000450019, 487.46378983118285, 631.1416473595906, 639.159505250594, 646.7154452041087, 3401.353742788912, 3536.6286539913453, 3574.767640103385, 3611.7652352596997, 3644.0514326172647, 53313.73343133259, 54136.45863541393, 54215.186772198445, 54286.728566357706, 55080.0, 47691.284630730566, 47999.0, 49555.50444495509, 51407.22889156666, 52247.0, 42893.78553107277, 42951.570484295386, 46192.769036155274, 46808.0, 47772.522274776806, 8077.353811695168, 8332.666693332441, 8611.440256383315, 8668.869966950628, 8789.780255493664, 28061.0, 29020.0, 29981.70018299789, 30199.0, 30216.94240701565, 37466.62533374631, 37888.242235155696, 39048.80475597604, 39309.41035884521, 39485.210295794495, 10874.510647021061, 11041.779164416826, 11077.113830893348, 11260.38067906273, 11268.549258029587, 10667.0, 10763.300385474919, 11840.585579504675, 11961.880381196424, 12037.578684745991, 10343.689689309333, 10561.313514621525, 10646.254762166574, 11019.283746556448, 11025.558977641125, 10786.191035672513, 11053.171012173958, 11215.439228038402, 11223.66329010131, 11949.761004779682, 10345.0, 10387.428691422045, 10506.94746526293, 10899.836502452312, 11081.612143574936, 8540.316774658137, 8721.694740684046, 8747.693830715894, 8836.116388361112, 8895.555222238992, 9164.95417522908, 9300.162985331353, 9383.812323753351, 9478.146966773023, 9667.274954378308], "value": 5992.664425373273, "unit": "score"}], "name": "dromaeo_css", "value": 6193.836548623265, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 108.0, 112.0, 114.0, 116.0, 101.0, 112.0, 114.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 160.0, 184.0, 135.0, 160.0, 153.0, 133.0, 193.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 159.0, 163.0, 163.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 100.0, 106.0, 77.0, 79.0, 73.0, 115.0, 102.0, 77.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 149.0, 94.0, 95.0, 94.0, 146.0, 94.0, 102.0, 137.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 149.0, 146.0, 146.0, 147.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 80.0, 62.0, 61.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 81.0, 79.0, 80.0, 79.0, 80.0, 88.0, 79.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 132.0, 135.0, 140.0, 132.0, 132.0, 133.0, 179.0, 135.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 213.0, 217.0, 220.0, 214.0, 214.0, 214.0, 216.0, 211.0, 218.0], "value": 215.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 75.0, 74.0, 74.0, 75.0, 73.0, 73.0, 75.0, 74.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1625.9, "alertThreshold": 2.0}]} 08:45:09 INFO - Return code: 0 08:45:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:45:09 ERROR - # TBPL SUCCESS # 08:45:09 INFO - Running post-action listener: _resource_record_post_action 08:45:09 INFO - Running post-run listener: _resource_record_post_run 08:45:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526938112; Read time: 16; Write time: 480196 08:45:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243961856; Read time: 0; Write time: 309976 08:45:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282976256; Read time: 16; Write time: 170220 08:45:10 INFO - Running post-run listener: _upload_blobber_files 08:45:10 INFO - Blob upload gear active. 08:45:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:10 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 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:45:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:11 INFO - (blobuploader) - INFO - Done attempting. 08:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:12 INFO - (blobuploader) - INFO - Done attempting. 08:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:12 INFO - Return code: 0 08:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/053acd6d5e52d76026b900836ebb0ff126b204b510f0277f5e21855a9d03ae0771bd9b8a5e825a27a6f7d7d1d1d3bd5d25240f39daf0f8ffbb8fb0915d134e73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306ba9d9d6446f18b5a10a2fe1d41732416dac613ac80d94987c07a38b92103be97133a4ddc4e4b82ebbae3844e3a522bd49bbd6b6ca467b0d9053045d77fab3"} 08:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:12 INFO - Contents: 08:45:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/053acd6d5e52d76026b900836ebb0ff126b204b510f0277f5e21855a9d03ae0771bd9b8a5e825a27a6f7d7d1d1d3bd5d25240f39daf0f8ffbb8fb0915d134e73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306ba9d9d6446f18b5a10a2fe1d41732416dac613ac80d94987c07a38b92103be97133a4ddc4e4b82ebbae3844e3a522bd49bbd6b6ca467b0d9053045d77fab3"} 08:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:12 INFO - Copying logs to upload dir... 08:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.620387 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-28 08:45:12.707512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:45:12.711468) ========= 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=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/053acd6d5e52d76026b900836ebb0ff126b204b510f0277f5e21855a9d03ae0771bd9b8a5e825a27a6f7d7d1d1d3bd5d25240f39daf0f8ffbb8fb0915d134e73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306ba9d9d6446f18b5a10a2fe1d41732416dac613ac80d94987c07a38b92103be97133a4ddc4e4b82ebbae3844e3a522bd49bbd6b6ca467b0d9053045d77fab3"} build_url:https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/Qeu49_agRkGyo781m7biRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/053acd6d5e52d76026b900836ebb0ff126b204b510f0277f5e21855a9d03ae0771bd9b8a5e825a27a6f7d7d1d1d3bd5d25240f39daf0f8ffbb8fb0915d134e73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306ba9d9d6446f18b5a10a2fe1d41732416dac613ac80d94987c07a38b92103be97133a4ddc4e4b82ebbae3844e3a522bd49bbd6b6ca467b0d9053045d77fab3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:45:12.736595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:45:12.736918) ========= 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=0e2a256762fed810e2f0f810000001b3-1461856986.719063-1427751756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:45:12.820998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:45:12.821307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:45:12.821608) ========= ========= Total master_lag: 0.16 =========