builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1462879185.99 results: success (0) buildid: 20160510030406 builduid: 6b80c9eba73f4fc9a62005ceb48ee94e revision: 1522462dc6209910989b252fcfe307a9a0ddc281 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:45.991658) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:45.992090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:45.992373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:46.008357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:46.008634) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 04:19:46-- 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% 224M=0s 2016-05-10 04:19:46 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:46.093616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:46.096987) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014153 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:46.146307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:19:46.146640) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1522462dc6209910989b252fcfe307a9a0ddc281 --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 1522462dc6209910989b252fcfe307a9a0ddc281 --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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 04:19:46,193 truncating revision to first 12 chars 2016-05-10 04:19:46,193 Setting DEBUG logging. 2016-05-10 04:19:46,193 attempt 1/10 2016-05-10 04:19:46,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1522462dc620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 04:19:46,980 unpacking tar archive at: mozilla-central-1522462dc620/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045349 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:19:47.207757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:47.208083) ========= script_repo_revision: 1522462dc6209910989b252fcfe307a9a0ddc281 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:47.208490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:47.208780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:19:47.218630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-10 04:19:47.218915) ========= /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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:47 INFO - MultiFileLogger online at 20160510 04:19:47 in /builds/slave/test 04:19:47 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 04:19:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:47 INFO - {'append_to_log': False, 04:19:47 INFO - 'base_work_dir': '/builds/slave/test', 04:19:47 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:19:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:47 INFO - 'branch': 'Firefox-Non-PGO', 04:19:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:47 INFO - 'config_files': ('talos/linux_config.py',), 04:19:47 INFO - 'default_actions': ('clobber', 04:19:47 INFO - 'read-buildbot-config', 04:19:47 INFO - 'download-and-extract', 04:19:47 INFO - 'populate-webroot', 04:19:47 INFO - 'create-virtualenv', 04:19:47 INFO - 'install', 04:19:47 INFO - 'run-tests'), 04:19:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:47 INFO - 'download_minidump_stackwalk': True, 04:19:47 INFO - 'download_symbols': 'ondemand', 04:19:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:47 INFO - 'installer_path': 'installer.exe', 04:19:47 INFO - 'log_level': 'info', 04:19:47 INFO - 'log_name': 'talos', 04:19:47 INFO - 'log_to_console': True, 04:19:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:47 INFO - 'opt_config_files': (), 04:19:47 INFO - 'pip_index': False, 04:19:47 INFO - 'sps_profile': False, 04:19:47 INFO - 'sps_profile_interval': 0, 04:19:47 INFO - 'suite': 'dromaeojs', 04:19:47 INFO - 'system_bits': '32', 04:19:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:47 INFO - 'title': 'talos-linux64-ix-024', 04:19:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:47 INFO - 'use_talos_json': True, 04:19:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:47 INFO - 'work_dir': 'build'} 04:19:47 INFO - ##### 04:19:47 INFO - ##### Running clobber step. 04:19:47 INFO - ##### 04:19:47 INFO - Running pre-action listener: _resource_record_pre_action 04:19:47 INFO - Running main action method: clobber 04:19:47 INFO - rmtree: /builds/slave/test/build 04:19:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:47 INFO - Running post-action listener: _resource_record_post_action 04:19:47 INFO - ##### 04:19:47 INFO - ##### Finished clobber step (success) 04:19:47 INFO - ##### 04:19:47 INFO - ##### 04:19:47 INFO - ##### Running read-buildbot-config step. 04:19:47 INFO - ##### 04:19:47 INFO - Running pre-action listener: _resource_record_pre_action 04:19:47 INFO - Running main action method: read_buildbot_config 04:19:47 INFO - Using buildbot properties: 04:19:47 INFO - { 04:19:47 INFO - "project": "", 04:19:47 INFO - "product": "firefox", 04:19:47 INFO - "script_repo_revision": "production", 04:19:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:19:47 INFO - "repository": "", 04:19:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:19:47 INFO - "buildid": "20160510030406", 04:19:47 INFO - "pgo_build": "False", 04:19:47 INFO - "basedir": "/builds/slave/test", 04:19:47 INFO - "buildnumber": 567, 04:19:47 INFO - "slavename": "talos-linux64-ix-024", 04:19:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:19:47 INFO - "platform": "ubuntu64_hw", 04:19:47 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:19:47 INFO - "branch": "mozilla-central", 04:19:47 INFO - "repo_path": "mozilla-central", 04:19:47 INFO - "revision": "1522462dc6209910989b252fcfe307a9a0ddc281", 04:19:47 INFO - "stage_platform": "linux64", 04:19:47 INFO - "builduid": "6b80c9eba73f4fc9a62005ceb48ee94e", 04:19:47 INFO - "slavebuilddir": "test" 04:19:47 INFO - } 04:19:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:19:47 INFO - Running post-action listener: _resource_record_post_action 04:19:47 INFO - ##### 04:19:47 INFO - ##### Finished read-buildbot-config step (success) 04:19:47 INFO - ##### 04:19:47 INFO - ##### 04:19:47 INFO - ##### Running download-and-extract step. 04:19:47 INFO - ##### 04:19:47 INFO - Running pre-action listener: _resource_record_pre_action 04:19:47 INFO - Running main action method: download_and_extract 04:19:47 INFO - mkdir: /builds/slave/test/build/tests 04:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:47 INFO - https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:19:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:19:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:19:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:48 INFO - Downloaded 1361 bytes. 04:19:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:19:48 INFO - Using the following test package requirements: 04:19:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:19:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'jsshell-linux-x86_64.zip'], 04:19:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19: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')]} 04:19:48 INFO - https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:49 INFO - Downloaded 22322613 bytes. 04:19:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:19:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:19:50 INFO - Return code: 0 04:19:50 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 04:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:50 INFO - https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:52 INFO - Downloaded 22322613 bytes. 04:19:52 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'] 04:19:52 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 04:19:53 INFO - Return code: 0 04:19: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')]} 04:19:53 INFO - https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:54 INFO - Downloaded 10840152 bytes. 04:19:54 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'] 04:19:54 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 04:19:54 INFO - Return code: 0 04:19:54 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')]} 04:19:54 INFO - https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L1ezG45GS3eml_SeRmC10A/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 04:19:56 INFO - Downloaded 54859524 bytes. 04:19:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:19:56 INFO - mkdir: /builds/slave/test/properties 04:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:56 INFO - Contents: 04:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - Running post-action listener: set_extra_try_arguments 04:19:57 INFO - ##### 04:19:57 INFO - ##### Finished download-and-extract step (success) 04:19:57 INFO - ##### 04:19:57 INFO - ##### 04:19:57 INFO - ##### Running populate-webroot step. 04:19:57 INFO - ##### 04:19:57 INFO - Running pre-action listener: _resource_record_pre_action 04:19:57 INFO - Running main action method: populate_webroot 04:19:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:57 INFO - '--tppagecycles', 04:19:57 INFO - '7'], 04:19:57 INFO - 'tests': ['tsvgm']}}, 04:19:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['damp', 'tps']}, 04:19:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['damp', 'tps']}, 04:19:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['dromaeo_dom']}, 04:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tsvgx', 04:19:57 INFO - 'tsvgr_opacity', 04:19:57 INFO - 'tart', 04:19:57 INFO - 'tscrollx', 04:19:57 INFO - 'cart']}, 04:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:57 INFO - 'tsvgr_opacity', 04:19:57 INFO - 'tart', 04:19:57 INFO - 'tscrollx', 04:19:57 INFO - 'cart']}, 04:19:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tp5o']}, 04:19:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['tp5o']}, 04:19:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s', 04:19:57 INFO - '--xperf_path', 04:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:57 INFO - 'tests': ['tp5n']}, 04:19:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--xperf_path', 04:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:57 INFO - 'tests': ['tp5n']}}, 04:19:57 INFO - 'talos.zip': {'path': '', 04:19:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - ##### 04:19:57 INFO - ##### Finished populate-webroot step (success) 04:19:57 INFO - ##### 04:19:57 INFO - ##### 04:19:57 INFO - ##### Running create-virtualenv step. 04:19:57 INFO - ##### 04:19:57 INFO - Running pre-action listener: _resource_record_pre_action 04:19:57 INFO - Running main action method: create_virtualenv 04:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:57 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 04:19:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:57 INFO - Using real prefix '/usr' 04:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:59 INFO - Installing pip.................done. 04:19:59 INFO - Return code: 0 04:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:19:59 INFO - Using env: {'DISPLAY': ':0', 04:19:59 INFO - 'HOME': '/home/cltbld', 04:19:59 INFO - 'LANG': 'en_US.UTF-8', 04:19:59 INFO - 'LANGUAGE': 'en_US:en', 04:19:59 INFO - 'LOGNAME': 'cltbld', 04:19:59 INFO - 'MAIL': '/var/mail/cltbld', 04:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:59 INFO - 'MOZ_NO_REMOTE': '1', 04:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:59 INFO - 'NO_EM_RESTART': '1', 04:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:59 INFO - 'PWD': '/builds/slave/test', 04:19:59 INFO - 'SHELL': '/bin/bash', 04:19:59 INFO - 'SHLVL': '1', 04:19:59 INFO - 'TERM': 'linux', 04:19:59 INFO - 'TMOUT': '86400', 04:19:59 INFO - 'USER': 'cltbld', 04:19:59 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:59 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 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 04:20:00 INFO - Cleaning up... 04:20:00 INFO - Return code: 0 04:20:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:20:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 INFO - 'MAIL': '/var/mail/cltbld', 04:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:00 INFO - 'MOZ_NO_REMOTE': '1', 04:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:00 INFO - 'NO_EM_RESTART': '1', 04:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:00 INFO - 'PWD': '/builds/slave/test', 04:20:00 INFO - 'SHELL': '/bin/bash', 04:20:00 INFO - 'SHLVL': '1', 04:20:00 INFO - 'TERM': 'linux', 04:20:00 INFO - 'TMOUT': '86400', 04:20:00 INFO - 'USER': 'cltbld', 04:20:00 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:00 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 INFO - Downloading/unpacking psutil>=0.7.1 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:02 INFO - Installing collected packages: psutil 04:20:02 INFO - Running setup.py install for psutil 04:20:02 INFO - building 'psutil._psutil_linux' extension 04:20:02 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 04:20:02 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 04:20:02 INFO - building 'psutil._psutil_posix' extension 04:20:02 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 04:20:02 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 04:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:02 INFO - Successfully installed psutil 04:20:02 INFO - Cleaning up... 04:20:02 INFO - Return code: 0 04:20:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:20:02 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')]} 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:02 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')]} 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:02 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:02 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 04:20:02 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 04:20:02 INFO - Using env: {'DISPLAY': ':0', 04:20:02 INFO - 'HOME': '/home/cltbld', 04:20:02 INFO - 'LANG': 'en_US.UTF-8', 04:20:02 INFO - 'LANGUAGE': 'en_US:en', 04:20:02 INFO - 'LOGNAME': 'cltbld', 04:20:02 INFO - 'MAIL': '/var/mail/cltbld', 04:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:02 INFO - 'MOZ_NO_REMOTE': '1', 04:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:02 INFO - 'NO_EM_RESTART': '1', 04:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:02 INFO - 'PWD': '/builds/slave/test', 04:20:02 INFO - 'SHELL': '/bin/bash', 04:20:02 INFO - 'SHLVL': '1', 04:20:02 INFO - 'TERM': 'linux', 04:20:02 INFO - 'TMOUT': '86400', 04:20:02 INFO - 'USER': 'cltbld', 04:20:02 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:02 INFO - '_': '/tools/buildbot/bin/python'} 04:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:20:04 INFO - Installing collected packages: mozsystemmonitor 04:20:04 INFO - Running setup.py install for mozsystemmonitor 04:20:05 INFO - Successfully installed mozsystemmonitor 04:20:05 INFO - Cleaning up... 04:20:05 INFO - Return code: 0 04:20:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:05 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:05 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 04:20:05 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 04:20:05 INFO - Using env: {'DISPLAY': ':0', 04:20:05 INFO - 'HOME': '/home/cltbld', 04:20:05 INFO - 'LANG': 'en_US.UTF-8', 04:20:05 INFO - 'LANGUAGE': 'en_US:en', 04:20:05 INFO - 'LOGNAME': 'cltbld', 04:20:05 INFO - 'MAIL': '/var/mail/cltbld', 04:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:05 INFO - 'MOZ_NO_REMOTE': '1', 04:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:05 INFO - 'NO_EM_RESTART': '1', 04:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:05 INFO - 'PWD': '/builds/slave/test', 04:20:05 INFO - 'SHELL': '/bin/bash', 04:20:05 INFO - 'SHLVL': '1', 04:20:05 INFO - 'TERM': 'linux', 04:20:05 INFO - 'TMOUT': '86400', 04:20:05 INFO - 'USER': 'cltbld', 04:20:05 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:05 INFO - '_': '/tools/buildbot/bin/python'} 04:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:07 INFO - Downloading docopt-0.6.1.tar.gz 04:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:07 INFO - Running setup.py install for blobuploader 04:20:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:08 INFO - Running setup.py install for requests 04:20:08 INFO - Running setup.py install for docopt 04:20:08 INFO - Successfully installed blobuploader requests docopt 04:20:08 INFO - Cleaning up... 04:20:08 INFO - Return code: 0 04:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:08 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:08 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 04:20:08 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 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:08 INFO - Running setup.py (path:/tmp/pip-r6ETma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:08 INFO - Running setup.py (path:/tmp/pip-1pJLhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:08 INFO - Running setup.py (path:/tmp/pip-S1xfVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:08 INFO - Running setup.py (path:/tmp/pip-sGXR83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:09 INFO - Running setup.py (path:/tmp/pip-RoZW5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:09 INFO - Running setup.py (path:/tmp/pip-l0op3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:09 INFO - Running setup.py (path:/tmp/pip-4yyTGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:09 INFO - Running setup.py (path:/tmp/pip-6_Qe1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:09 INFO - Running setup.py (path:/tmp/pip-dvKmAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:09 INFO - Running setup.py (path:/tmp/pip-vHYobG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:09 INFO - Running setup.py (path:/tmp/pip-ut67QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:09 INFO - Running setup.py (path:/tmp/pip-NfkwNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:09 INFO - Running setup.py (path:/tmp/pip-XEseM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:09 INFO - Running setup.py (path:/tmp/pip-H1GLXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:09 INFO - Running setup.py (path:/tmp/pip-Hi5Fb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:09 INFO - Running setup.py (path:/tmp/pip-0WUF5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:09 INFO - Running setup.py (path:/tmp/pip-sOTsCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:09 INFO - Running setup.py install for manifestparser 04:20:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for mozcrash 04:20:10 INFO - Running setup.py install for mozdebug 04:20:10 INFO - Running setup.py install for mozdevice 04:20:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for mozfile 04:20:10 INFO - Running setup.py install for mozhttpd 04:20:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for mozinfo 04:20:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for mozInstall 04:20:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for mozleak 04:20:10 INFO - Running setup.py install for mozlog 04:20:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:10 INFO - Running setup.py install for moznetwork 04:20:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Running setup.py install for mozprocess 04:20:11 INFO - Running setup.py install for mozprofile 04:20:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Running setup.py install for mozrunner 04:20:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Running setup.py install for mozscreenshot 04:20:11 INFO - Running setup.py install for moztest 04:20:11 INFO - Running setup.py install for mozversion 04:20:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:11 INFO - Cleaning up... 04:20:11 INFO - Return code: 0 04:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:11 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:11 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 04:20:11 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 04:20:11 INFO - Using env: {'DISPLAY': ':0', 04:20:11 INFO - 'HOME': '/home/cltbld', 04:20:11 INFO - 'LANG': 'en_US.UTF-8', 04:20:11 INFO - 'LANGUAGE': 'en_US:en', 04:20:11 INFO - 'LOGNAME': 'cltbld', 04:20:11 INFO - 'MAIL': '/var/mail/cltbld', 04:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:11 INFO - 'MOZ_NO_REMOTE': '1', 04:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:11 INFO - 'NO_EM_RESTART': '1', 04:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:11 INFO - 'PWD': '/builds/slave/test', 04:20:11 INFO - 'SHELL': '/bin/bash', 04:20:11 INFO - 'SHLVL': '1', 04:20:11 INFO - 'TERM': 'linux', 04:20:11 INFO - 'TMOUT': '86400', 04:20:11 INFO - 'USER': 'cltbld', 04:20:11 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:11 INFO - '_': '/tools/buildbot/bin/python'} 04:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:11 INFO - Running setup.py (path:/tmp/pip-NQPXiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:12 INFO - Running setup.py (path:/tmp/pip-CKoeBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:12 INFO - Running setup.py (path:/tmp/pip-QyiPx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:12 INFO - Running setup.py (path:/tmp/pip-MGXJP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:12 INFO - Running setup.py (path:/tmp/pip-nRqCab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:12 INFO - Running setup.py (path:/tmp/pip-_CoSLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:12 INFO - Running setup.py (path:/tmp/pip-7zVQSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:12 INFO - Running setup.py (path:/tmp/pip-gRYNNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:12 INFO - Running setup.py (path:/tmp/pip-vkNvtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:12 INFO - Running setup.py (path:/tmp/pip-p1GaBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:12 INFO - Running setup.py (path:/tmp/pip-cmSZlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:12 INFO - Running setup.py (path:/tmp/pip-xn06_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:12 INFO - Running setup.py (path:/tmp/pip-KDThUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:12 INFO - Running setup.py (path:/tmp/pip-j33Ucn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:12 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)) 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:12 INFO - Running setup.py (path:/tmp/pip-yZ3VPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:13 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)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:13 INFO - Running setup.py (path:/tmp/pip-gknInH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:13 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)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:13 INFO - Running setup.py (path:/tmp/pip-Pu1MEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:13 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)) 04:20:13 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)) 04:20:13 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)) 04:20:13 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)) 04:20:13 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)) 04:20:13 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)) 04:20:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:15 INFO - Downloading blessings-1.6.tar.gz 04:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:15 INFO - Installing collected packages: blessings 04:20:15 INFO - Running setup.py install for blessings 04:20:15 INFO - Successfully installed blessings 04:20:15 INFO - Cleaning up... 04:20:15 INFO - Return code: 0 04:20:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:15 INFO - Reading from file tmpfile_stdout 04:20:15 INFO - Current package versions: 04:20:15 INFO - argparse == 1.2.1 04:20:15 INFO - blessings == 1.6 04:20:15 INFO - blobuploader == 1.2.4 04:20:15 INFO - docopt == 0.6.1 04:20:15 INFO - manifestparser == 1.1 04:20:15 INFO - mozInstall == 1.12 04:20:15 INFO - mozcrash == 0.17 04:20:15 INFO - mozdebug == 0.1 04:20:15 INFO - mozdevice == 0.48 04:20:15 INFO - mozfile == 1.2 04:20:15 INFO - mozhttpd == 0.7 04:20:15 INFO - mozinfo == 0.9 04:20:15 INFO - mozleak == 0.1 04:20:15 INFO - mozlog == 3.1 04:20:15 INFO - moznetwork == 0.27 04:20:15 INFO - mozprocess == 0.22 04:20:15 INFO - mozprofile == 0.28 04:20:15 INFO - mozrunner == 6.11 04:20:15 INFO - mozscreenshot == 0.1 04:20:15 INFO - mozsystemmonitor == 0.0 04:20:15 INFO - moztest == 0.7 04:20:15 INFO - mozversion == 1.4 04:20:15 INFO - psutil == 3.1.1 04:20:15 INFO - requests == 1.2.3 04:20:15 INFO - wsgiref == 0.1.2 04:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:15 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 04:20:15 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 04:20:15 INFO - Using env: {'DISPLAY': ':0', 04:20:15 INFO - 'HOME': '/home/cltbld', 04:20:15 INFO - 'LANG': 'en_US.UTF-8', 04:20:15 INFO - 'LANGUAGE': 'en_US:en', 04:20:15 INFO - 'LOGNAME': 'cltbld', 04:20:15 INFO - 'MAIL': '/var/mail/cltbld', 04:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:15 INFO - 'MOZ_NO_REMOTE': '1', 04:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:15 INFO - 'NO_EM_RESTART': '1', 04:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:15 INFO - 'PWD': '/builds/slave/test', 04:20:15 INFO - 'SHELL': '/bin/bash', 04:20:15 INFO - 'SHLVL': '1', 04:20:15 INFO - 'TERM': 'linux', 04:20:15 INFO - 'TMOUT': '86400', 04:20:15 INFO - 'USER': 'cltbld', 04:20:15 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:15 INFO - '_': '/tools/buildbot/bin/python'} 04:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 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)) 04:20:15 INFO - Cleaning up... 04:20:15 INFO - Return code: 0 04:20:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:15 INFO - Using env: {'DISPLAY': ':0', 04:20:15 INFO - 'HOME': '/home/cltbld', 04:20:15 INFO - 'LANG': 'en_US.UTF-8', 04:20:15 INFO - 'LANGUAGE': 'en_US:en', 04:20:15 INFO - 'LOGNAME': 'cltbld', 04:20:15 INFO - 'MAIL': '/var/mail/cltbld', 04:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:15 INFO - 'MOZ_NO_REMOTE': '1', 04:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:15 INFO - 'NO_EM_RESTART': '1', 04:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:15 INFO - 'PWD': '/builds/slave/test', 04:20:15 INFO - 'SHELL': '/bin/bash', 04:20:15 INFO - 'SHLVL': '1', 04:20:15 INFO - 'TERM': 'linux', 04:20:15 INFO - 'TMOUT': '86400', 04:20:15 INFO - 'USER': 'cltbld', 04:20:15 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:15 INFO - '_': '/tools/buildbot/bin/python'} 04:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:15 INFO - Downloading/unpacking jsonschema 04:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:18 INFO - warning: no files found matching '*.txt' 04:20:18 INFO - no previously-included directories found matching 'build' 04:20:18 INFO - no previously-included directories found matching 'dist' 04:20:18 INFO - no previously-included directories found matching '.git*' 04:20:18 INFO - Installing collected packages: jsonschema, functools32 04:20:18 INFO - Running setup.py install for functools32 04:20:18 INFO - warning: no files found matching '*.txt' 04:20:18 INFO - no previously-included directories found matching 'build' 04:20:18 INFO - no previously-included directories found matching 'dist' 04:20:18 INFO - no previously-included directories found matching '.git*' 04:20:18 INFO - Successfully installed jsonschema functools32 04:20:18 INFO - Cleaning up... 04:20:18 INFO - Return code: 0 04:20:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20:18 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')]} 04:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:18 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')]} 04:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:18 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 0x7f4ed55a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', '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 04:20:18 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 04:20:18 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 04:20:18 INFO - Using env: {'DISPLAY': ':0', 04:20:18 INFO - 'HOME': '/home/cltbld', 04:20:18 INFO - 'LANG': 'en_US.UTF-8', 04:20:18 INFO - 'LANGUAGE': 'en_US:en', 04:20:18 INFO - 'LOGNAME': 'cltbld', 04:20:18 INFO - 'MAIL': '/var/mail/cltbld', 04:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:18 INFO - 'MOZ_NO_REMOTE': '1', 04:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:18 INFO - 'NO_EM_RESTART': '1', 04:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:18 INFO - 'PWD': '/builds/slave/test', 04:20:18 INFO - 'SHELL': '/bin/bash', 04:20:18 INFO - 'SHLVL': '1', 04:20:18 INFO - 'TERM': 'linux', 04:20:18 INFO - 'TMOUT': '86400', 04:20:18 INFO - 'USER': 'cltbld', 04:20:18 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:18 INFO - '_': '/tools/buildbot/bin/python'} 04:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:18 INFO - Downloading/unpacking flake8 04:20:18 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 04:20:18 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 04:20:18 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 04:20:18 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 04:20:18 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 04:20:18 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 04:20:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:20 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 04:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:21 INFO - no previously-included directories found matching 'docs/_build' 04:20:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:21 INFO - Running setup.py install for pep8 04:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:21 INFO - no previously-included directories found matching 'docs/_build' 04:20:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:21 INFO - Cleaning up... 04:20:21 INFO - Return code: 0 04:20:21 INFO - Running post-action listener: _resource_record_post_action 04:20:21 INFO - Running post-action listener: _start_resource_monitoring 04:20:21 INFO - Starting resource monitoring. 04:20:21 INFO - ##### 04:20:21 INFO - ##### Finished create-virtualenv step (success) 04:20:21 INFO - ##### 04:20:21 INFO - ##### 04:20:21 INFO - ##### Running install step. 04:20:21 INFO - ##### 04:20:21 INFO - Running pre-action listener: _resource_record_pre_action 04:20:21 INFO - Running main action method: install 04:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:21 INFO - Reading from file tmpfile_stdout 04:20:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:21 INFO - Reading from file tmpfile_stdout 04:20:21 INFO - Output received: 04:20:21 INFO - Usage: mozinstall [options] installer 04:20:21 INFO - Options: 04:20:21 INFO - -h, --help show this help message and exit 04:20:21 INFO - -d DEST, --destination=DEST 04:20:21 INFO - Directory to install application into. [default: 04:20:21 INFO - "/builds/slave/test"] 04:20:21 INFO - --app=APP Application being installed. [default: firefox] 04:20:21 INFO - mkdir: /builds/slave/test/build/application 04:20:21 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'] 04:20:21 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 04:20:37 INFO - Reading from file tmpfile_stdout 04:20:37 INFO - Output received: 04:20:37 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:37 INFO - Running post-action listener: _resource_record_post_action 04:20:37 INFO - ##### 04:20:37 INFO - ##### Finished install step (success) 04:20:37 INFO - ##### 04:20:37 INFO - ##### 04:20:37 INFO - ##### Running run-tests step. 04:20:37 INFO - ##### 04:20:37 INFO - Running pre-action listener: _resource_record_pre_action 04:20:37 INFO - Running main action method: run_tests 04:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:37 INFO - Python 2.7.3 04:20:37 INFO - Return code: 0 04:20:37 INFO - grabbing minidump binary from tooltool 04:20: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')]} 04:20:37 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 0x1d7f9c0>, '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 0x1d808c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d80d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:37 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 04:20:37 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 04:20:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:37 INFO - Return code: 0 04:20:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:38 INFO - Return code: 0 04:20:38 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/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:20:38 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/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:20:38 INFO - Using env: {'DISPLAY': ':0', 04:20:38 INFO - 'HOME': '/home/cltbld', 04:20:38 INFO - 'LANG': 'en_US.UTF-8', 04:20:38 INFO - 'LANGUAGE': 'en_US:en', 04:20:38 INFO - 'LOGNAME': 'cltbld', 04:20:38 INFO - 'MAIL': '/var/mail/cltbld', 04:20:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:38 INFO - 'MOZ_NO_REMOTE': '1', 04:20:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:38 INFO - 'NO_EM_RESTART': '1', 04:20:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:38 INFO - 'PWD': '/builds/slave/test', 04:20:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:38 INFO - 'SHELL': '/bin/bash', 04:20:38 INFO - 'SHLVL': '1', 04:20:38 INFO - 'TERM': 'linux', 04:20:38 INFO - 'TMOUT': '86400', 04:20:38 INFO - 'USER': 'cltbld', 04:20:38 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413', 04:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:38 INFO - '_': '/tools/buildbot/bin/python'} 04:20:38 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/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:20:38 INFO - mozversion application_buildid: 20160510030406 04:20:38 INFO - mozversion application_changeset: 1522462dc6209910989b252fcfe307a9a0ddc281 04:20:38 INFO - mozversion application_display_name: Nightly 04:20:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:38 INFO - mozversion application_name: Firefox 04:20:38 INFO - mozversion application_remotingname: firefox 04:20:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:38 INFO - mozversion application_vendor: Mozilla 04:20:38 INFO - mozversion application_version: 49.0a1 04:20:38 INFO - mozversion platform_buildid: 20160510030406 04:20:38 INFO - mozversion platform_changeset: 1522462dc6209910989b252fcfe307a9a0ddc281 04:20:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:38 INFO - mozversion platform_version: 49.0a1 04:20:38 INFO - using testdate: 1462879238 04:20:38 INFO - actual date: 1462879238 04:20:38 INFO - starting webserver on 'localhost:59686' 04:20:38 INFO - SUITE-START | Running 2 tests 04:20:38 INFO - TEST-START | dromaeo_css 04:20:38 INFO - operating with platform_type : linux_ 04:20:38 INFO - Initialising browser for dromaeo_css test... 04:20:38 INFO - TEST-INFO | started process 31276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRlYdA/profile http://localhost:59686/getInfo.html) 04:20:42 INFO - PROCESS | 31276 | __metrics Screen width/height:1600/1200 04:20:42 INFO - PROCESS | 31276 | colorDepth:24 04:20:42 INFO - PROCESS | 31276 | Browser inner width/height: 1024/697 04:20:42 INFO - PROCESS | 31276 | __metrics 04:20:43 ERROR - PROCESS | 31276 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:44 INFO - TEST-INFO | 31276: exit 0 04:20:44 INFO - Browser initialized. 04:20:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:44 INFO - TEST-INFO | started process 31357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRlYdA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:56 INFO - PROCESS | 31357 | RSS: Main: 153804800 04:20:56 INFO - PROCESS | 31357 | 04:21:48 INFO - PROCESS | 31357 | 1462879308123 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] 04:23:59 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59686/tests/dromaeo/cssquery-ext.html) 04:24:00 INFO - PROCESS | 31357 | RSS: Main: 268689408 04:24:00 INFO - PROCESS | 31357 | 04:27:03 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-ext.html (next: http://localhost:59686/tests/dromaeo/cssquery-jquery.html) 04:27:03 INFO - PROCESS | 31357 | RSS: Main: 239681536 04:27:03 INFO - PROCESS | 31357 | 04:30:05 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59686/tests/dromaeo/cssquery-mootools.html) 04:30:06 INFO - PROCESS | 31357 | RSS: Main: 243089408 04:30:06 INFO - PROCESS | 31357 | 04:33:08 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59686/tests/dromaeo/cssquery-prototype.html) 04:33:09 INFO - PROCESS | 31357 | RSS: Main: 239923200 04:33:09 INFO - PROCESS | 31357 | 04:36:12 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59686/tests/dromaeo/cssquery-yui.html) 04:36:12 INFO - PROCESS | 31357 | RSS: Main: 207982592 04:36:12 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | Cycle 1(1): loaded http://localhost:59686/tests/dromaeo/cssquery-yui.html (next: http://localhost:59686/tests/dromaeo/cssquery-dojo.html) 04:39:15 INFO - PROCESS | 31357 | RSS: Main: 265478144 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | __start_tp_report 04:39:15 INFO - PROCESS | 31357 | _x_x_mozilla_page_load 04:39:15 INFO - PROCESS | 31357 | _x_x_mozilla_page_load_details 04:39:15 INFO - PROCESS | 31357 | |i|pagename|runs| 04:39:15 INFO - PROCESS | 31357 | |0;dojo.html;2659.7606215440605;2661.946761064779;2693.4747724193776;2701.0276300531805;2703.3376822678447;4619.907601847961;4665.9066818663605;4671.50949150339;4737.952620473794;4790.9760451197735;4726.574608285254;4752.334673145762;4816.205326121186;4846.34574332465;4894.143524883149;4352.934705979397;4356.586124318184;4379.912401751963;4471.150481408538;4519.909601807962;4395.516493185747;4478.126765280772;4555.954440455586;4574.83988060418;4613.953860461403;4293.162833247518;4524.457065152203;4546.29532422475;4562.657800664931;4578.725276483405;4315.82736690532;4319.956800431987;4368.104538569617;4423;4434.977825110854;4399.274119770234;4451.799669014902;4454.688171827974;4467.508574056851;4486.865394038184;4543.613792827614;4785.880352991168;4788.904221915543;4796.664233503656;4818.10864989978;5053.772580233898;5099.643024988252;5103.030424219386;5133.383993920754;5161.045206636747;5118.436971933084;5160.7419629018395;5174;5179.04187725272;5193.065248255312;4687.484376718558;4758.428988521399;4886.193778026657;4891.706497610119;4901.705897646153;5249.790008399621;5279.366476022902;5291.100512912814;5297.973510132501;5300.310959575308;5031.647784655112;5032.597392208614;5077.949220507748;5083.135866902636;5083.364579427572;4884.267359896044;5102.08162530748;5102.438731739506;5107.33604631403;5123.077845987684;5129.589632829365;5180.766865491062;5181.611379146579;5186.118359878829;5232.502912223333;5150.716710580954;5158.664686795346;5172.922406163911;5176.818811341585;5222.947770522323;4276.273033584236;4326.329418940069;4363.716358436755;4439.9778001110435;4445.866624001285;3814.0464883779055;3819.3125237457525;3822.5604055533413;3842.4620553122586;3893.922121557553;4349.478062632441;4366.410534577855;4374.256376416017;4377.562243775661;4406.757628330409;4900.019996000743;5104.132297509433;5154.845354639367;5156.535911767959;5191.636585439059;4364.148990946735;4382.167388196232;4399.054203346232;4415.867523974286;4442.400275962768;4659.813607455664;4673.672842901033;4677.415323084614;4678.064387122589;4704.435467743892;4670.252759558454;4779.569838714532;4803.975980120077;4825.831095911626;4850.151223535867;5120.231965205249;5137.897242055213;5139.8458046258675;5139.92290115656;5208.322918020633;4822.493638168082;4823.204171311834;4823.614110871192;4838.467768545527;4841.782119804547;4929.211326187936;5009.699418034784;5061.645684802029;5085.644004919768;5108.795648174031;5134.768935397841;5150.536451719363;5154.123798954111;5164.277001219757;5233.39815921174;4857.077155340474;4997.750112494434;5004.274380214775;5006.098902197639;5010.949890501049;4948.851534453972;4988.052270068675;5008;5009.974950125226;5021.573166280761;4932.926006109839;4935.037667654773;4991.700497970133;5005.449400566008;5006.399232092027;4817.373741413734;4989.650724449254;5068.239764035424;5095.898082038264;5116.334876466036;4791.568758811584;4793.209120495079;4830.806767729251;4919.065377578248;4922.433920099091 04:39:15 INFO - PROCESS | 31357 | |1;ext.html;553.872609299861;603.8248907816734;605.2283338743105;605.9454649081582;615.3415845045802;42304.36543451847;43901.56098439015;43995.56004439955;44008.77995610022;48464.75767621166;44173.77913110438;44833.7758311208;44886.55113448865;44891.55108448915;44949.77525112378;7878.251566101226;7990.960045199766;8007.479513831611;8025.478343907656;8030.397720170981;7870.606469676522;7954.681812727484;7959.72140975066;7960.4825686330205;7963.681452741884;7962.0843602985815;8003.439759216857;8004.279614834663;8007.879881801778;8009.439339246255;7879.093904200976;7903.881441778378;7920.445568810157;7956.681732730655;7967.920320796834;7722.806929826743;7822.647980840876;7877.133515313311;7877.487963282426;7881.645325960346;39853.80073099645;40365.59634403648;40390.79804600988;40392.192156157005;40437.19125617501;3293.143782616513;3441.9311613767836;3783.4324851272254;3956.8219430125714;4003.399490076512;29691.109266722033;30079.548806767914;30190;30368;30445.391092178033;2994.5059065254427;3047.481928072233;3076.9230769230726;3082.892098776532;3160.5733226014654;254063;255691;256011;256076;256095;55413.060542880805;55443.72278138583;55526.444735552126;55577.444225558036;55894.72052639792;58499.4150058494;58769.70615146982;58823.70588147032;58825.70587147037;58949.41050589525;12893.548725794552;14553.854461455461;14790.408383664533;14793.408263669333;14798.63003424923;9600.903990960142;10599.364038157735;10922.726931826768;10928.890711092947;11222.270552414067;16263.349466021227;16691.666166676598;16879.493615191564;17272.22274997628;17340.566485837702;6623.9732841408695;6695.531312808057;6756;6769.32306769329;6838.829029274209;888.3293113699116;972.2562239886493;996.4270544436978;999.3853779925294;1017.1405162637559;28643.14070577886;29291.414171716446;29375.55936660952;29785;29865.55201671977;1018.8420794776821;1020.9948950255201;1060.4273692206277;1096.155959910864;1177.5172179406402;15454.922725386301;15651.217439127999;15740.560213166977;15825.841741582668;15900.92049539745;369452;369908;372185.94698370853;374524;374775;52423.21365179525;52585.73707131516;52683.73658131685;52766.47233527616;52783;1167.0838391862517;1179.7671433352168;1248.5380409248637;1284.563248495516;1297.5328881602616;26163;30225;30541;31008.68991310058;31015.224619383793;42828.785856071765;43315;43548.78225608852;43566;43571.78214108909;285771;286382;286603;286849;286887;26090.347741306618;27246.727532725214;27278.454430910875;28587.571186431804;36374.27251455009;43746.562534375524;43924.121517568834;44358.33462498001;44968.77515612401;45328.54671453243;37026.6297337034;37314.8134259327;38073;38201.23597528089;38436.61563384442;37377.4393384094;37781;37893.81053094717;38108.428373573865;38338;36226.09434764152;36971.815140924125;37086.44370334501;37485.62514374821;37565.4365184517;32127;33761.49357759685;33780.493292601124;33918.491222631186;33992.66007339895;26122.738772612032;26324.341891452867;26327.868360658074;26330.4733905317;26352.20943371702 04:39:15 INFO - PROCESS | 31357 | |2;jquery.html;370.8961490782581;376.2137133391213;380.5794596970348;393.9409088636704;399.6822526091757;16440.17799110044;16710.746693997953;17567.736483952736;17615.207315670792;18183.090845457707;10265.435401052939;10825.350478971268;10828.729281767959;10832.837507437374;10836.837447438274;4396.340548917672;4616.492185859553;4812.0857037163005;5393.2719082923895;5441.129419292914;5416.268803711508;5469.863253418676;5470.64440811348;5477.260569823063;5517.393086760453;5370.838874833742;5465.808696695616;5517.282753242073;5552.888942221153;5561.916571251434;5443.755031023594;5474;5478.835634930959;5489.615726899138;5492.972535137299;5083.567896728782;5412;5425.782968681248;5430.239766432703;5438.456154384569;11916.582919597859;12255.632331030083;12555.372231388485;12654.746905061847;12755.681107972283;1983.335582579823;2067.1860417529783;2216.700745399383;2331.918382856609;2460.9261722148362;9358.15776580111;9884.802303953953;9965.501724913725;12518.624441266686;12810.871891281062;1819.1306941027387;1899.0504747626187;1899.2308115213361;1925.922963081475;1971.152404466079;74818.62590687012;75761.62119189369;76216.61891690562;76435;76504.99999999945;9188.632454701738;9317.673881414254;9792.804143917081;9932.453715045598;9963.651272205438;13277.402516886763;13353.933230333787;13391.866081339256;13403.597892063253;13461.461541538425;7130.465215108784;7193.208747037822;7254;7304.342609165201;7352.264773522712;6990.510664253454;6999.615021173782;7003.299670033058;7157.2127066022695;7157.89263161053;4009.3184158693093;4019.588247051804;4060.817263223162;4091.2226676931286;4138.358554424069;1832.9826946044807;1862.6926557118195;1885.3495544037285;1903.3528600275972;1966.9311574094838;1006.8942761009988;1012.4937531234383;1024.3085917005992;1029.264076185531;1030.5620111452602;16683.49949501517;17577;17702.29190832378;17739.37912173068;18099.819001809814;881.6517475597103;909.8726178335038;940.4498368454394;986.6448078691665;1019.1184625299063;9765.9023409765;9933.453660048623;9983.101520863158;10092.192624590016;10093.142082923034;400279;400493;405483;406956;408652;46546.53453465422;63263;63479.36520634734;78986.60506697545;80723;962.167724917941;973.3284034016506;985.4629227071264;991.2763682511951;991.3655260633201;15458.84541154574;15695.921520392325;15779.36882524732;15873.841261587237;16118.758218626495;34520.48219276763;35845.46231806577;36162.276754464234;36296.63703363038;38175.61824381832;49278;50493.74753126211;50530.74734626451;50671;50879.23681144712;7748.9612551939135;7834.960825195838;7877.448578599672;7944.880826787718;8011.439199255996;8257.504549727035;8464.915350846413;8560.91439085601;8562.100979397073;8649.351298652751;7443.627818609156;7506.737264195727;7796.337311328601;7873.881891771743;7922.027753840695;7500.362469189961;7679.308862202429;7706.614669266626;7714.228577142241;8097.554634495159;7814.492058016211;7834.177411371724;7986.041674999037;8079;8142.267195952156;10841.783164336826;11080.501377437873;11506.654800356002;11581.131415144066;12091.637250882488;11239.775204496027;11340.829887551858;11380.658580242605;11387.715307117389;11563.595274165364 04:39:15 INFO - PROCESS | 31357 | |3;mootools.html;1231.9630411087671;1485.502356710502;1511.8639322460979;1681.9548984691821;1837.9172937217816;7032.613206273653;7275.199728029919;7335.413166946645;7406.59263740494;7436.628168591576;7190.6404679766065;7340.302671246223;7355.154157271915;7358.22738612446;7373.705051797935;1879.285871368878;2157.0077764228395;2169.8915054247304;2199.2082850173924;2254.785795349439;2255.796978271955;2261.118163916074;2264.4338915271182;2267.8979445924974;2268.353519247015;2183.6287831068676;2236.7651396603364;2242.159190303636;2243.607368710477;2245.719285089364;1832.9266829326878;2126.5002724359842;2192.9451763705874;2200.559888022386;2201.6917631531596;2210.469487323047;2238.2725614175456;2244.8540844845197;2251.954960900789;2314.884255787204;7364.7790566282565;7408.888866667005;7414.6292685365515;7415.88876166858;7423.554586724814;4492.146492166478;4588.4952655208235;4623.768811559408;4627.8611641650805;4657.04530571232;2886.870090845917;2898.6956369581103;2919.7080291970633;2933.2080338308538;2963.2888106854416;924.96300147994;956.2588993530001;968.4286271100085;977.6529332087149;991.6182269826169;9491.905080949171;9602.471864047475;9725.173360264385;9741.415515069048;9825.950870245675;4093.324601440729;4160.355144952477;4248.192843359751;4264.232438161161;4270.530241673413;8369.539675317916;8495.617697203641;8519.74440766778;8573.18554737299;8588.098249683693;4003.6997225208224;4580.358749775034;4584.404027476407;4624.5375462453485;4628.606568441653;4046.4132700758223;4149.2738770715005;4176.60322269384;4213.367994800743;4213.557576454489;3648.069742215771;3660.066682995819;3725.5715592706642;3756.286305601927;3787;1168.684455197109;1177.1171621284036;1184.7808155491261;1206.0291465370285;1236.486857953939;914.5107367558325;914.5655813488672;915.0666320353203;928.4375124655998;940.1632547033146;5078.187490001582;5115.437301896788;5132.178851383761;5175.948240517622;5261.447548007404;419.5888029730881;426.1285670803215;439.35414940038095;439.984600538986;441.8563966710832;3613.223157021253;3633.9636603634153;3641;3716.6840818530727;3719.20037192005;8785.428947118417;8962.879640044994;9022.368434209542;9146.725598232064;9169.449833010041;8847.292216622654;8956.193942545202;8967.551622418852;8973.057828927998;9016.909830901606;6431.163948686641;6699.397054265042;6883;6968.3728464438445;7017.89473157903;5235.240890070994;5282.867928301823;5295.602829787705;5371.0869152244995;5381.784728610812;7973.445178190197;8068.9596552016865;8232.135625759209;8292.2951549119;8306.916930830614;8289.668413263644;8290.212429819157;8300.792480188044;8350.206730360605;8441.282490988335;5968.641881487125;6330.208723909512;6539.247986481425;6547.672616369257;6640.800775976729;7167.964160179165;7184.928150718426;7254.854902902018;7257;7260.927390726025;6451.870962580816;6510.283868774336;6565.737370505318;6620.867582648417;6650.268470468148;6506.804795856132;6523.967380163259;6555.082288479712;6602.801915942529;6675.766348177791;6278.780242691667;6311.905321420274;6348.682565871595;6360.141380913517;6361.300256971637;4375.628071613948;4401.36180253855;4483.910321793481;4507.323901414683;4522.321651752132;4307.569243075667;4407.889802754957;4410.382546443565;4416.955830441783;4502.954970450384 04:39:15 INFO - PROCESS | 31357 | |4;prototype.html;311.72256691544527;314.40734216002835;321.8101320221069;322.3826372496669;324.2331885091759;4842.443119041307;4864.464908860023;4864.781084851182;4873.829415970442;4898.387701537308;4784.66507344486;4804.231322988323;4818.397700287455;4822.276658501227;4833.202521583943;3869.2454971280613;3882.941755873664;3885.378339465693;3899.9665088751362;3912.2762288976487;3771.7925514096714;3858.6527212550864;3875.360565506688;3892.338302488584;3892.9221415571674;3773.490578771858;3791.563970143441;3798.5821559628557;3819.847206111766;3834.7699138051807;3638.43604241343;3817.8663746769007;3822.1591249924973;3824.368979118442;3837.9232415351676;3228.741700663941;3364.9158771030675;3385.492176173569;3389.4237979543536;3391.1522119470133;4529.84145554904;4557.156925968707;4558.77206139695;4565.977170114162;4622.306654001893;4107.527634322061;4233.364995250707;4333.674974376934;4348.391225228471;4371.584699453547;5006.69959802413;5010.974945125251;5025.1708468102715;5026.371703537058;5043.268726034741;3643.1802844360072;3651.94522082169;3655.94516082259;3658.8536458541626;3665.21197942441;5040.180006428815;5229.895402091937;5249.212618107276;5266.631335806495;5284.180951952453;3733.75730577517;3733.962660373416;3743.756655817363;3745.9625403745613;3766.3597188478025;3830.9042273943373;3847.1920896611464;3850.114473671071;3875.7286989910435;3898;4364.3851774843515;4374.147041326911;4385.890352741207;4395.428594282723;4409.536998615164;4868.269759536098;5028.849134525897;5076.238564215398;5092.337996060489;5114.5652619527755;1279.2772083772638;1279.8144269081117;1291.2245662214455;1295.436485128972;1307.8038294255937;892.9374943754004;909.7725568607848;918.5223683684446;925.5696101312922;936.1481052242426;4239.491261048694;4243.68172387066;4269.5516970718245;4269.786510674454;4295.72077814941;4989.725565093882;5018.698878067255;5043.2435134730085;5045.5459008689395;5051.116054690415;4267.551907049778;4307.633851122627;4310.633596144363;4310.719803212781;4311.827526898889;2524.5203411351786;2684.463107378532;2686.9328266793095;2695.2183866678442;2696.393311504896;4794.161021821167;4819.855404337875;4832.420109586872;4833.3958255218095;4843.975780121077;4951.603871690256;5099.64302498829;5140.485951404829;5206.7917283309;5236.659617124875;4863.635227357962;4863.708177509361;4866.513348665176;4870.732109733999;4877.0735559453815;5029.899402012013;5033.245013248042;5074.847754567369;5075.441701412916;5097.490250974873;4820.39745031871;4986.301917731593;5073.619478539198;5084.440711521804;5099.79600815978;4898.975505122452;4944.035912996931;4945.727984960861;4959;4969;3691.7231207658997;3698.8176975584533;3720.8697695580527;3741.96258037427;3743.326201283795;5033.84898453047;5287;5297.496737809902;5308.25684404176;5334.226537152169;5040.773165207501;5043.646944713835;5046.621503387334;5052.520010598987;5074.568661663652;5043.193089105725;5057.494250574913;5062.835727670206;5068.442471328225;5074.644774865872;4707.4351077869505;4974.303597496426;4997.775100120431;4999.250112483157;5002.624803139852;4826.444958829639;4929.728864912321;5058;5070.3155074064525;5094.719790411563;4977.253411988231;4979.601631869514;4982.900341993212;4988.9501104988485;4991.425986011655 04:39:15 INFO - PROCESS | 31357 | |5;yui.html;748.5022460064058;755.6221889055472;800.6157044618581;818.0551463060168;824.32817253938;11057.50241239144;11795.882041179586;12029.218100823462;12058.698532536691;12131.757364852709;11973.940130299336;12025.27848329101;12108.334041627708;12376.938115309433;12399.69000774981;872.9869051964209;874.899386570543;876.2508055612456;876.2902049340023;879.248242752447;680.7243066558052;696.568127760789;855.102142750113;873.388627960427;878.4246318661287;867.2411639815161;867.9175478329548;868.6221493650282;869.5087275689247;869.76516340588;869.5956380283135;870.1429092344099;870.8171284030361;871.525018864717;871.8038441350709;518.1062666899605;657.644871769244;672.132948496439;672.3612568060362;679.9558028728167;11641;11679.240849344766;11681.299122052704;11683;11702.88297117035;10551.366917984946;10656.307340022873;10758.354498730023;10977.780444391148;11144.973859610016;10010.249231307609;10112.646057387956;10224.335418197794;10365.74085647865;10453.268271221017;4040.113190686585;4093.9590604093873;4096.836126554934;4120.793960301973;4200.159968006411;43096.3535546967;43112.3533147003;43114.35328470044;43435;43631.90920226988;8751.212390884724;8893.110688931056;8894.59974301158;8902.643894244287;8980.191782739585;16740.330386784637;16776.748348774778;16790.81719376473;16814.075225862696;16959.15204239783;6055.515558755377;6199.907001394983;6351.872962540723;6379.330170332141;6404.103425520338;3583.964160358415;3636;3639.1993761372455;3667.9816600916824;3689.3543629864666;2836.1066264126734;2923.9122826315242;2929.5459203823443;2929.6045033920573;2934.823910565373;565.0817421689754;582.2954225387329;588.6468119128574;596.2397942623104;600.7777122464717;542.3464725006357;559.2757379193954;600.471799270848;619.9101130336076;649.0880313160018;7559.979402780664;7596.3922886168975;7754.7673569793;7882.684692612232;7993.840123197503;626.7868924565579;626.8683576448997;642.2966851297822;650.6421468192475;668.2682462703332;3641.0715267606593;3697.2605478904325;3697.963020369762;3803.6386543278345;3916.80537436079;52505;52635.210471842955;53417.732911335195;54130;54311;48322.758386207846;49460.258096128586;49660;50141;51145.23282150771;44010.33984490235;44498.77750611226;44701.77649111669;44944.77527612341;45068;7376.889346659912;7408.777736667908;7446.664900079618;7633.160352361125;7654.770356889302;30521.23696907595;30870.845645772526;30885.382292354476;30992;31156;36561.81719091388;37032.25935481329;39612.80193599014;39802.80098599489;39894.40158397568;9403.81192376135;9613.134817866425;9621.374610650286;9725.902740972782;9732.367396119229;10485;10694.89305106939;10731.678049658523;11058.944705276745;11079.113670906469;8271.958640207002;10451.581936722447;10749.301295415773;10941.945290273497;11230;10753.731156721145;10767.784644307227;10823.56705731762;10983.560657573607;11125.833112503156;10117.645882394081;10120.89879101229;10676.57293708243;10746.516406761872;10926.289791163548;8922.86615700752;9020.458772473672;9067.546622668971;9299.442033478013;9322.580483878377;9001.864972025294;9025.232855207381;9257.21313688344;9617.903820961701;9664.178544823768 04:39:15 INFO - PROCESS | 31357 | __end_tp_report 04:39:15 INFO - PROCESS | 31357 | __start_cc_report 04:39:15 INFO - PROCESS | 31357 | _x_x_mozilla_cycle_collect,1076 04:39:15 INFO - PROCESS | 31357 | __end_cc_report 04:39:15 INFO - PROCESS | 31357 | __startTimestamp1462880355938__endTimestamp 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | ------- Summary: start ------- 04:39:15 INFO - PROCESS | 31357 | Number of tests: 6 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#0] dojo.html Cycles:165 Average:4746.01 Median:4841.78 stddev:494.87 (10.2%) stddev-sans-first:468.55 04:39:15 INFO - PROCESS | 31357 | Values: 2659.8 2661.9 2693.5 2701.0 2703.3 4619.9 4665.9 4671.5 4738.0 4791.0 4726.6 4752.3 4816.2 4846.3 4894.1 4352.9 4356.6 4379.9 4471.2 4519.9 4395.5 4478.1 4556.0 4574.8 4614.0 4293.2 4524.5 4546.3 4562.7 4578.7 4315.8 4320.0 4368.1 4423.0 4435.0 4399.3 4451.8 4454.7 4467.5 4486.9 4543.6 4785.9 4788.9 4796.7 4818.1 5053.8 5099.6 5103.0 5133.4 5161.0 5118.4 5160.7 5174.0 5179.0 5193.1 4687.5 4758.4 4886.2 4891.7 4901.7 5249.8 5279.4 5291.1 5298.0 5300.3 5031.6 5032.6 5077.9 5083.1 5083.4 4884.3 5102.1 5102.4 5107.3 5123.1 5129.6 5180.8 5181.6 5186.1 5232.5 5150.7 5158.7 5172.9 5176.8 5222.9 4276.3 4326.3 4363.7 4440.0 4445.9 3814.0 3819.3 3822.6 3842.5 3893.9 4349.5 4366.4 4374.3 4377.6 4406.8 4900.0 5104.1 5154.8 5156.5 5191.6 4364.1 4382.2 4399.1 4415.9 4442.4 4659.8 4673.7 4677.4 4678.1 4704.4 4670.3 4779.6 4804.0 4825.8 4850.2 5120.2 5137.9 5139.8 5139.9 5208.3 4822.5 4823.2 4823.6 4838.5 4841.8 4929.2 5009.7 5061.6 5085.6 5108.8 5134.8 5150.5 5154.1 5164.3 5233.4 4857.1 4997.8 5004.3 5006.1 5010.9 4948.9 4988.1 5008.0 5010.0 5021.6 4932.9 4935.0 4991.7 5005.4 5006.4 4817.4 4989.7 5068.2 5095.9 5116.3 4791.6 4793.2 4830.8 4919.1 4922.4 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#1] ext.html Cycles:180 Average:47344.06 Median:20782.22 stddev:80991.96 (389.7%) stddev-sans-first:81142.97 04:39:15 INFO - PROCESS | 31357 | Values: 553.9 603.8 605.2 605.9 615.3 42304.4 43901.6 43995.6 44008.8 48464.8 44173.8 44833.8 44886.6 44891.6 44949.8 7878.3 7991.0 8007.5 8025.5 8030.4 7870.6 7954.7 7959.7 7960.5 7963.7 7962.1 8003.4 8004.3 8007.9 8009.4 7879.1 7903.9 7920.4 7956.7 7967.9 7722.8 7822.6 7877.1 7877.5 7881.6 39853.8 40365.6 40390.8 40392.2 40437.2 3293.1 3441.9 3783.4 3956.8 4003.4 29691.1 30079.5 30190.0 30368.0 30445.4 2994.5 3047.5 3076.9 3082.9 3160.6 254063.0 255691.0 256011.0 256076.0 256095.0 55413.1 55443.7 55526.4 55577.4 55894.7 58499.4 58769.7 58823.7 58825.7 58949.4 12893.5 14553.9 14790.4 14793.4 14798.6 9600.9 10599.4 10922.7 10928.9 11222.3 16263.3 16691.7 16879.5 17272.2 17340.6 6624.0 6695.5 6756.0 6769.3 6838.8 888.3 972.3 996.4 999.4 1017.1 28643.1 29291.4 29375.6 29785.0 29865.6 1018.8 1021.0 1060.4 1096.2 1177.5 15454.9 15651.2 15740.6 15825.8 15900.9 369452.0 369908.0 372185.9 374524.0 374775.0 52423.2 52585.7 52683.7 52766.5 52783.0 1167.1 1179.8 1248.5 1284.6 1297.5 26163.0 30225.0 30541.0 31008.7 31015.2 42828.8 43315.0 43548.8 43566.0 43571.8 285771.0 286382.0 286603.0 286849.0 286887.0 26090.3 27246.7 27278.5 28587.6 36374.3 43746.6 43924.1 44358.3 44968.8 45328.5 37026.6 37314.8 38073.0 38201.2 38436.6 37377.4 37781.0 37893.8 38108.4 38338.0 36226.1 36971.8 37086.4 37485.6 37565.4 32127.0 33761.5 33780.5 33918.5 33992.7 26122.7 26324.3 26327.9 26330.5 26352.2 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#2] jquery.html Cycles:180 Average:24117.44 Median:50512.25 stddev:66700.44 (132.0%) stddev-sans-first:66863.72 04:39:15 INFO - PROCESS | 31357 | Values: 370.9 376.2 380.6 393.9 399.7 16440.2 16710.7 17567.7 17615.2 18183.1 10265.4 10825.4 10828.7 10832.8 10836.8 4396.3 4616.5 4812.1 5393.3 5441.1 5416.3 5469.9 5470.6 5477.3 5517.4 5370.8 5465.8 5517.3 5552.9 5561.9 5443.8 5474.0 5478.8 5489.6 5493.0 5083.6 5412.0 5425.8 5430.2 5438.5 11916.6 12255.6 12555.4 12654.7 12755.7 1983.3 2067.2 2216.7 2331.9 2460.9 9358.2 9884.8 9965.5 12518.6 12810.9 1819.1 1899.1 1899.2 1925.9 1971.2 74818.6 75761.6 76216.6 76435.0 76505.0 9188.6 9317.7 9792.8 9932.5 9963.7 13277.4 13353.9 13391.9 13403.6 13461.5 7130.5 7193.2 7254.0 7304.3 7352.3 6990.5 6999.6 7003.3 7157.2 7157.9 4009.3 4019.6 4060.8 4091.2 4138.4 1833.0 1862.7 1885.3 1903.4 1966.9 1006.9 1012.5 1024.3 1029.3 1030.6 16683.5 17577.0 17702.3 17739.4 18099.8 881.7 909.9 940.4 986.6 1019.1 9765.9 9933.5 9983.1 10092.2 10093.1 400279.0 400493.0 405483.0 406956.0 408652.0 46546.5 63263.0 63479.4 78986.6 80723.0 962.2 973.3 985.5 991.3 991.4 15458.8 15695.9 15779.4 15873.8 16118.8 34520.5 35845.5 36162.3 36296.6 38175.6 49278.0 50493.7 50530.7 50671.0 50879.2 7749.0 7835.0 7877.4 7944.9 8011.4 8257.5 8464.9 8560.9 8562.1 8649.4 7443.6 7506.7 7796.3 7873.9 7922.0 7500.4 7679.3 7706.6 7714.2 8097.6 7814.5 7834.2 7986.0 8079.0 8142.3 10841.8 11080.5 11506.7 11581.1 12091.6 11239.8 11340.8 11380.7 11387.7 11563.6 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#3] mootools.html Cycles:180 Average:4936.76 Median:5272.16 stddev:2644.76 (50.2%) stddev-sans-first:2637.52 04:39:15 INFO - PROCESS | 31357 | Values: 1232.0 1485.5 1511.9 1682.0 1837.9 7032.6 7275.2 7335.4 7406.6 7436.6 7190.6 7340.3 7355.2 7358.2 7373.7 1879.3 2157.0 2169.9 2199.2 2254.8 2255.8 2261.1 2264.4 2267.9 2268.4 2183.6 2236.8 2242.2 2243.6 2245.7 1832.9 2126.5 2192.9 2200.6 2201.7 2210.5 2238.3 2244.9 2252.0 2314.9 7364.8 7408.9 7414.6 7415.9 7423.6 4492.1 4588.5 4623.8 4627.9 4657.0 2886.9 2898.7 2919.7 2933.2 2963.3 925.0 956.3 968.4 977.7 991.6 9491.9 9602.5 9725.2 9741.4 9826.0 4093.3 4160.4 4248.2 4264.2 4270.5 8369.5 8495.6 8519.7 8573.2 8588.1 4003.7 4580.4 4584.4 4624.5 4628.6 4046.4 4149.3 4176.6 4213.4 4213.6 3648.1 3660.1 3725.6 3756.3 3787.0 1168.7 1177.1 1184.8 1206.0 1236.5 914.5 914.6 915.1 928.4 940.2 5078.2 5115.4 5132.2 5175.9 5261.4 419.6 426.1 439.4 440.0 441.9 3613.2 3634.0 3641.0 3716.7 3719.2 8785.4 8962.9 9022.4 9146.7 9169.4 8847.3 8956.2 8967.6 8973.1 9016.9 6431.2 6699.4 6883.0 6968.4 7017.9 5235.2 5282.9 5295.6 5371.1 5381.8 7973.4 8069.0 8232.1 8292.3 8306.9 8289.7 8290.2 8300.8 8350.2 8441.3 5968.6 6330.2 6539.2 6547.7 6640.8 7168.0 7184.9 7254.9 7257.0 7260.9 6451.9 6510.3 6565.7 6620.9 6650.3 6506.8 6524.0 6555.1 6602.8 6675.8 6278.8 6311.9 6348.7 6360.1 6361.3 4375.6 4401.4 4483.9 4507.3 4522.3 4307.6 4407.9 4410.4 4417.0 4503.0 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#4] prototype.html Cycles:180 Average:4187.65 Median:4820.13 stddev:1193.77 (24.8%) stddev-sans-first:1161.13 04:39:15 INFO - PROCESS | 31357 | Values: 311.7 314.4 321.8 322.4 324.2 4842.4 4864.5 4864.8 4873.8 4898.4 4784.7 4804.2 4818.4 4822.3 4833.2 3869.2 3882.9 3885.4 3900.0 3912.3 3771.8 3858.7 3875.4 3892.3 3892.9 3773.5 3791.6 3798.6 3819.8 3834.8 3638.4 3817.9 3822.2 3824.4 3837.9 3228.7 3364.9 3385.5 3389.4 3391.2 4529.8 4557.2 4558.8 4566.0 4622.3 4107.5 4233.4 4333.7 4348.4 4371.6 5006.7 5011.0 5025.2 5026.4 5043.3 3643.2 3651.9 3655.9 3658.9 3665.2 5040.2 5229.9 5249.2 5266.6 5284.2 3733.8 3734.0 3743.8 3746.0 3766.4 3830.9 3847.2 3850.1 3875.7 3898.0 4364.4 4374.1 4385.9 4395.4 4409.5 4868.3 5028.8 5076.2 5092.3 5114.6 1279.3 1279.8 1291.2 1295.4 1307.8 892.9 909.8 918.5 925.6 936.1 4239.5 4243.7 4269.6 4269.8 4295.7 4989.7 5018.7 5043.2 5045.5 5051.1 4267.6 4307.6 4310.6 4310.7 4311.8 2524.5 2684.5 2686.9 2695.2 2696.4 4794.2 4819.9 4832.4 4833.4 4844.0 4951.6 5099.6 5140.5 5206.8 5236.7 4863.6 4863.7 4866.5 4870.7 4877.1 5029.9 5033.2 5074.8 5075.4 5097.5 4820.4 4986.3 5073.6 5084.4 5099.8 4899.0 4944.0 4945.7 4959.0 4969.0 3691.7 3698.8 3720.9 3742.0 3743.3 5033.8 5287.0 5297.5 5308.3 5334.2 5040.8 5043.6 5046.6 5052.5 5074.6 5043.2 5057.5 5062.8 5068.4 5074.6 4707.4 4974.3 4997.8 4999.3 5002.6 4826.4 4929.7 5058.0 5070.3 5094.7 4977.3 4979.6 4982.9 4989.0 4991.4 04:39:15 INFO - PROCESS | 31357 | 04:39:15 INFO - PROCESS | 31357 | [#5] yui.html Cycles:180 Average:12671.73 Median:49560.13 stddev:14757.19 (29.8%) stddev-sans-first:14771.43 04:39:15 INFO - PROCESS | 31357 | Values: 748.5 755.6 800.6 818.1 824.3 11057.5 11795.9 12029.2 12058.7 12131.8 11973.9 12025.3 12108.3 12376.9 12399.7 873.0 874.9 876.3 876.3 879.2 680.7 696.6 855.1 873.4 878.4 867.2 867.9 868.6 869.5 869.8 869.6 870.1 870.8 871.5 871.8 518.1 657.6 672.1 672.4 680.0 11641.0 11679.2 11681.3 11683.0 11702.9 10551.4 10656.3 10758.4 10977.8 11145.0 10010.2 10112.6 10224.3 10365.7 10453.3 4040.1 4094.0 4096.8 4120.8 4200.2 43096.4 43112.4 43114.4 43435.0 43631.9 8751.2 8893.1 8894.6 8902.6 8980.2 16740.3 16776.7 16790.8 16814.1 16959.2 6055.5 6199.9 6351.9 6379.3 6404.1 3584.0 3636.0 3639.2 3668.0 3689.4 2836.1 2923.9 2929.5 2929.6 2934.8 565.1 582.3 588.6 596.2 600.8 542.3 559.3 600.5 619.9 649.1 7560.0 7596.4 7754.8 7882.7 7993.8 626.8 626.9 642.3 650.6 668.3 3641.1 3697.3 3698.0 3803.6 3916.8 52505.0 52635.2 53417.7 54130.0 54311.0 48322.8 49460.3 49660.0 50141.0 51145.2 44010.3 44498.8 44701.8 44944.8 45068.0 7376.9 7408.8 7446.7 7633.2 7654.8 30521.2 30870.8 30885.4 30992.0 31156.0 36561.8 37032.3 39612.8 39802.8 39894.4 9403.8 9613.1 9621.4 9725.9 9732.4 10485.0 10694.9 10731.7 11058.9 11079.1 8272.0 10451.6 10749.3 10941.9 11230.0 10753.7 10767.8 10823.6 10983.6 11125.8 10117.6 10120.9 10676.6 10746.5 10926.3 8922.9 9020.5 9067.5 9299.4 9322.6 9001.9 9025.2 9257.2 9617.9 9664.2 04:39:15 INFO - PROCESS | 31357 | -------- Summary: end -------- 04:39:15 INFO - PROCESS | 31357 | 04:39:16 INFO - TEST-INFO | 31357: exit 0 04:39:16 INFO - TEST-OK | dromaeo_css | took 1117993ms 04:39:16 INFO - TEST-START | kraken 04:39:16 INFO - operating with platform_type : linux_ 04:39:16 INFO - Initialising browser for kraken test... 04:39:16 INFO - TEST-INFO | started process 31533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGyINv/profile http://localhost:59686/getInfo.html) 04:39:20 INFO - PROCESS | 31533 | __metrics Screen width/height:1600/1200 04:39:20 INFO - PROCESS | 31533 | colorDepth:24 04:39:20 INFO - PROCESS | 31533 | Browser inner width/height: 1024/697 04:39:20 INFO - PROCESS | 31533 | __metrics 04:39:21 ERROR - PROCESS | 31533 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:39:22 INFO - TEST-INFO | 31533: exit 0 04:39:22 INFO - Browser initialized. 04:39:22 INFO - Running cycle 1/1 for kraken test... 04:39:22 INFO - TEST-INFO | started process 31614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGyINv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:34 INFO - PROCESS | 31614 | RSS: Main: 154238976 04:39:34 INFO - PROCESS | 31614 | 04:39:37 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59686/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:38 INFO - PROCESS | 31614 | RSS: Main: 209559552 04:39:38 INFO - PROCESS | 31614 | 04:39:41 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59686/tests/kraken/driver.html?testName=audio-dft) 04:39:41 INFO - PROCESS | 31614 | RSS: Main: 197611520 04:39:41 INFO - PROCESS | 31614 | 04:39:44 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59686/tests/kraken/driver.html?testName=audio-fft) 04:39:45 INFO - PROCESS | 31614 | RSS: Main: 266989568 04:39:45 INFO - PROCESS | 31614 | 04:39:47 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59686/tests/kraken/driver.html?testName=audio-oscillator) 04:39:48 INFO - PROCESS | 31614 | RSS: Main: 175812608 04:39:48 INFO - PROCESS | 31614 | 04:39:50 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:51 INFO - PROCESS | 31614 | RSS: Main: 179122176 04:39:51 INFO - PROCESS | 31614 | 04:39:54 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59686/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:55 INFO - PROCESS | 31614 | RSS: Main: 215760896 04:39:55 INFO - PROCESS | 31614 | 04:39:58 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59686/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:59 INFO - PROCESS | 31614 | RSS: Main: 214491136 04:39:59 INFO - PROCESS | 31614 | 04:40:02 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59686/tests/kraken/driver.html?testName=json-parse-financial) 04:40:03 INFO - PROCESS | 31614 | RSS: Main: 214839296 04:40:03 INFO - PROCESS | 31614 | 04:40:05 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:05 INFO - PROCESS | 31614 | RSS: Main: 210370560 04:40:05 INFO - PROCESS | 31614 | 04:40:07 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:08 INFO - PROCESS | 31614 | RSS: Main: 209100800 04:40:08 INFO - PROCESS | 31614 | 04:40:10 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:11 INFO - PROCESS | 31614 | RSS: Main: 212303872 04:40:11 INFO - PROCESS | 31614 | 04:40:14 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:14 INFO - PROCESS | 31614 | RSS: Main: 217022464 04:40:14 INFO - PROCESS | 31614 | 04:40:17 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:18 INFO - PROCESS | 31614 | RSS: Main: 216494080 04:40:18 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | Cycle 1(1): loaded http://localhost:59686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59686/tests/kraken/driver.html?testName=ai-astar) 04:40:20 INFO - PROCESS | 31614 | RSS: Main: 261914624 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | __start_tp_report 04:40:20 INFO - PROCESS | 31614 | _x_x_mozilla_page_load 04:40:20 INFO - PROCESS | 31614 | _x_x_mozilla_page_load_details 04:40:20 INFO - PROCESS | 31614 | |i|pagename|runs| 04:40:20 INFO - PROCESS | 31614 | |0;ai-astar;114;111;116;115;114;114;114;115;113;114 04:40:20 INFO - PROCESS | 31614 | |1;audio-beat-detection;159;129;158;210;134;166;160;132;187;132 04:40:20 INFO - PROCESS | 31614 | |2;audio-dft;160;160;162;163;164;161;162;162;162;160 04:40:20 INFO - PROCESS | 31614 | |3;audio-fft;77;76;76;152;77;76;76;76;132;75 04:40:20 INFO - PROCESS | 31614 | |4;audio-oscillator;92;94;149;92;93;94;130;93;92;124 04:40:20 INFO - PROCESS | 31614 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 04:40:20 INFO - PROCESS | 31614 | |6;imaging-darkroom;148;148;148;148;148;148;148;148;148;146 04:40:20 INFO - PROCESS | 31614 | |7;imaging-desaturate;96;95;95;95;95;95;95;97;95;95 04:40:20 INFO - PROCESS | 31614 | |8;json-parse-financial;66;66;67;65;66;66;66;66;65;65 04:40:20 INFO - PROCESS | 31614 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;64;65;65 04:40:20 INFO - PROCESS | 31614 | |10;stanford-crypto-aes;81;80;82;81;81;83;83;81;141;85 04:40:20 INFO - PROCESS | 31614 | |11;stanford-crypto-ccm;131;134;140;133;135;130;132;136;150;135 04:40:20 INFO - PROCESS | 31614 | |12;stanford-crypto-pbkdf2;173;174;173;172;177;174;171;173;173;172 04:40:20 INFO - PROCESS | 31614 | |13;stanford-crypto-sha256-iterative;68;73;68;68;69;67;68;68;66;67 04:40:20 INFO - PROCESS | 31614 | __end_tp_report 04:40:20 INFO - PROCESS | 31614 | __start_cc_report 04:40:20 INFO - PROCESS | 31614 | _x_x_mozilla_cycle_collect,2048 04:40:20 INFO - PROCESS | 31614 | __end_cc_report 04:40:20 INFO - PROCESS | 31614 | __startTimestamp1462880420402__endTimestamp 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | ------- Summary: start ------- 04:40:20 INFO - PROCESS | 31614 | Number of tests: 14 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.33 (1.2%) stddev-sans-first:1.41 04:40:20 INFO - PROCESS | 31614 | Values: 114.0 111.0 116.0 115.0 114.0 114.0 114.0 115.0 113.0 114.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:159.50 stddev:26.60 (16.7%) stddev-sans-first:28.20 04:40:20 INFO - PROCESS | 31614 | Values: 159.0 129.0 158.0 210.0 134.0 166.0 160.0 132.0 187.0 132.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.30 04:40:20 INFO - PROCESS | 31614 | Values: 160.0 160.0 162.0 163.0 164.0 161.0 162.0 162.0 162.0 160.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:28.18 (37.1%) stddev-sans-first:29.53 04:40:20 INFO - PROCESS | 31614 | Values: 77.0 76.0 76.0 152.0 77.0 76.0 76.0 76.0 132.0 75.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:92.50 stddev:20.97 (22.7%) stddev-sans-first:21.68 04:40:20 INFO - PROCESS | 31614 | Values: 92.0 94.0 149.0 92.0 93.0 94.0 130.0 93.0 92.0 124.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:40:20 INFO - PROCESS | 31614 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:40:20 INFO - PROCESS | 31614 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 146.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:40:20 INFO - PROCESS | 31614 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:40:20 INFO - PROCESS | 31614 | Values: 66.0 66.0 67.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:40:20 INFO - PROCESS | 31614 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 65.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:81.50 stddev:18.75 (23.0%) stddev-sans-first:19.72 04:40:20 INFO - PROCESS | 31614 | Values: 81.0 80.0 82.0 81.0 81.0 83.0 83.0 81.0 141.0 85.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.00 stddev:5.80 (4.3%) stddev-sans-first:5.90 04:40:20 INFO - PROCESS | 31614 | Values: 131.0 134.0 140.0 133.0 135.0 130.0 132.0 136.0 150.0 135.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 04:40:20 INFO - PROCESS | 31614 | Values: 173.0 174.0 173.0 172.0 177.0 174.0 171.0 173.0 173.0 172.0 04:40:20 INFO - PROCESS | 31614 | 04:40:20 INFO - PROCESS | 31614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.99 04:40:20 INFO - PROCESS | 31614 | Values: 68.0 73.0 68.0 68.0 69.0 67.0 68.0 68.0 66.0 67.0 04:40:20 INFO - PROCESS | 31614 | -------- Summary: end -------- 04:40:20 INFO - PROCESS | 31614 | 04:40:21 INFO - TEST-INFO | 31614: exit 0 04:40:21 INFO - TEST-OK | kraken | took 64917ms 04:40:21 INFO - SUITE-END | took 1182s 04:40:22 INFO - Completed test suite (00:19:43) 04:40:22 INFO - javascript benchmark 04:40:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.7606215440605, 2661.946761064779, 2693.4747724193776, 2701.0276300531805, 2703.3376822678447, 4619.907601847961, 4665.9066818663605, 4671.50949150339, 4737.952620473794, 4790.9760451197735, 4726.574608285254, 4752.334673145762, 4816.205326121186, 4846.34574332465, 4894.143524883149, 4352.934705979397, 4356.586124318184, 4379.912401751963, 4471.150481408538, 4519.909601807962, 4395.516493185747, 4478.126765280772, 4555.954440455586, 4574.83988060418, 4613.953860461403, 4293.162833247518, 4524.457065152203, 4546.29532422475, 4562.657800664931, 4578.725276483405, 4315.82736690532, 4319.956800431987, 4368.104538569617, 4423.0, 4434.977825110854, 4399.274119770234, 4451.799669014902, 4454.688171827974, 4467.508574056851, 4486.865394038184, 4543.613792827614, 4785.880352991168, 4788.904221915543, 4796.664233503656, 4818.10864989978, 5053.772580233898, 5099.643024988252, 5103.030424219386, 5133.383993920754, 5161.045206636747, 5118.436971933084, 5160.7419629018395, 5174.0, 5179.04187725272, 5193.065248255312, 4687.484376718558, 4758.428988521399, 4886.193778026657, 4891.706497610119, 4901.705897646153, 5249.790008399621, 5279.366476022902, 5291.100512912814, 5297.973510132501, 5300.310959575308, 5031.647784655112, 5032.597392208614, 5077.949220507748, 5083.135866902636, 5083.364579427572, 4884.267359896044, 5102.08162530748, 5102.438731739506, 5107.33604631403, 5123.077845987684, 5129.589632829365, 5180.766865491062, 5181.611379146579, 5186.118359878829, 5232.502912223333, 5150.716710580954, 5158.664686795346, 5172.922406163911, 5176.818811341585, 5222.947770522323, 4276.273033584236, 4326.329418940069, 4363.716358436755, 4439.9778001110435, 4445.866624001285, 3814.0464883779055, 3819.3125237457525, 3822.5604055533413, 3842.4620553122586, 3893.922121557553, 4349.478062632441, 4366.410534577855, 4374.256376416017, 4377.562243775661, 4406.757628330409, 4900.019996000743, 5104.132297509433, 5154.845354639367, 5156.535911767959, 5191.636585439059, 4364.148990946735, 4382.167388196232, 4399.054203346232, 4415.867523974286, 4442.400275962768, 4659.813607455664, 4673.672842901033, 4677.415323084614, 4678.064387122589, 4704.435467743892, 4670.252759558454, 4779.569838714532, 4803.975980120077, 4825.831095911626, 4850.151223535867, 5120.231965205249, 5137.897242055213, 5139.8458046258675, 5139.92290115656, 5208.322918020633, 4822.493638168082, 4823.204171311834, 4823.614110871192, 4838.467768545527, 4841.782119804547, 4929.211326187936, 5009.699418034784, 5061.645684802029, 5085.644004919768, 5108.795648174031, 5134.768935397841, 5150.536451719363, 5154.123798954111, 5164.277001219757, 5233.39815921174, 4857.077155340474, 4997.750112494434, 5004.274380214775, 5006.098902197639, 5010.949890501049, 4948.851534453972, 4988.052270068675, 5008.0, 5009.974950125226, 5021.573166280761, 4932.926006109839, 4935.037667654773, 4991.700497970133, 5005.449400566008, 5006.399232092027, 4817.373741413734, 4989.650724449254, 5068.239764035424, 5095.898082038264, 5116.334876466036, 4791.568758811584, 4793.209120495079, 4830.806767729251, 4919.065377578248, 4922.433920099091], "value": 4714.712367622993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.872609299861, 603.8248907816734, 605.2283338743105, 605.9454649081582, 615.3415845045802, 42304.36543451847, 43901.56098439015, 43995.56004439955, 44008.77995610022, 48464.75767621166, 44173.77913110438, 44833.7758311208, 44886.55113448865, 44891.55108448915, 44949.77525112378, 7878.251566101226, 7990.960045199766, 8007.479513831611, 8025.478343907656, 8030.397720170981, 7870.606469676522, 7954.681812727484, 7959.72140975066, 7960.4825686330205, 7963.681452741884, 7962.0843602985815, 8003.439759216857, 8004.279614834663, 8007.879881801778, 8009.439339246255, 7879.093904200976, 7903.881441778378, 7920.445568810157, 7956.681732730655, 7967.920320796834, 7722.806929826743, 7822.647980840876, 7877.133515313311, 7877.487963282426, 7881.645325960346, 39853.80073099645, 40365.59634403648, 40390.79804600988, 40392.192156157005, 40437.19125617501, 3293.143782616513, 3441.9311613767836, 3783.4324851272254, 3956.8219430125714, 4003.399490076512, 29691.109266722033, 30079.548806767914, 30190.0, 30368.0, 30445.391092178033, 2994.5059065254427, 3047.481928072233, 3076.9230769230726, 3082.892098776532, 3160.5733226014654, 254063.0, 255691.0, 256011.0, 256076.0, 256095.0, 55413.060542880805, 55443.72278138583, 55526.444735552126, 55577.444225558036, 55894.72052639792, 58499.4150058494, 58769.70615146982, 58823.70588147032, 58825.70587147037, 58949.41050589525, 12893.548725794552, 14553.854461455461, 14790.408383664533, 14793.408263669333, 14798.63003424923, 9600.903990960142, 10599.364038157735, 10922.726931826768, 10928.890711092947, 11222.270552414067, 16263.349466021227, 16691.666166676598, 16879.493615191564, 17272.22274997628, 17340.566485837702, 6623.9732841408695, 6695.531312808057, 6756.0, 6769.32306769329, 6838.829029274209, 888.3293113699116, 972.2562239886493, 996.4270544436978, 999.3853779925294, 1017.1405162637559, 28643.14070577886, 29291.414171716446, 29375.55936660952, 29785.0, 29865.55201671977, 1018.8420794776821, 1020.9948950255201, 1060.4273692206277, 1096.155959910864, 1177.5172179406402, 15454.922725386301, 15651.217439127999, 15740.560213166977, 15825.841741582668, 15900.92049539745, 369452.0, 369908.0, 372185.94698370853, 374524.0, 374775.0, 52423.21365179525, 52585.73707131516, 52683.73658131685, 52766.47233527616, 52783.0, 1167.0838391862517, 1179.7671433352168, 1248.5380409248637, 1284.563248495516, 1297.5328881602616, 26163.0, 30225.0, 30541.0, 31008.68991310058, 31015.224619383793, 42828.785856071765, 43315.0, 43548.78225608852, 43566.0, 43571.78214108909, 285771.0, 286382.0, 286603.0, 286849.0, 286887.0, 26090.347741306618, 27246.727532725214, 27278.454430910875, 28587.571186431804, 36374.27251455009, 43746.562534375524, 43924.121517568834, 44358.33462498001, 44968.77515612401, 45328.54671453243, 37026.6297337034, 37314.8134259327, 38073.0, 38201.23597528089, 38436.61563384442, 37377.4393384094, 37781.0, 37893.81053094717, 38108.428373573865, 38338.0, 36226.09434764152, 36971.815140924125, 37086.44370334501, 37485.62514374821, 37565.4365184517, 32127.0, 33761.49357759685, 33780.493292601124, 33918.491222631186, 33992.66007339895, 26122.738772612032, 26324.341891452867, 26327.868360658074, 26330.4733905317, 26352.20943371702], "value": 18124.32685292513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8961490782581, 376.2137133391213, 380.5794596970348, 393.9409088636704, 399.6822526091757, 16440.17799110044, 16710.746693997953, 17567.736483952736, 17615.207315670792, 18183.090845457707, 10265.435401052939, 10825.350478971268, 10828.729281767959, 10832.837507437374, 10836.837447438274, 4396.340548917672, 4616.492185859553, 4812.0857037163005, 5393.2719082923895, 5441.129419292914, 5416.268803711508, 5469.863253418676, 5470.64440811348, 5477.260569823063, 5517.393086760453, 5370.838874833742, 5465.808696695616, 5517.282753242073, 5552.888942221153, 5561.916571251434, 5443.755031023594, 5474.0, 5478.835634930959, 5489.615726899138, 5492.972535137299, 5083.567896728782, 5412.0, 5425.782968681248, 5430.239766432703, 5438.456154384569, 11916.582919597859, 12255.632331030083, 12555.372231388485, 12654.746905061847, 12755.681107972283, 1983.335582579823, 2067.1860417529783, 2216.700745399383, 2331.918382856609, 2460.9261722148362, 9358.15776580111, 9884.802303953953, 9965.501724913725, 12518.624441266686, 12810.871891281062, 1819.1306941027387, 1899.0504747626187, 1899.2308115213361, 1925.922963081475, 1971.152404466079, 74818.62590687012, 75761.62119189369, 76216.61891690562, 76435.0, 76504.99999999945, 9188.632454701738, 9317.673881414254, 9792.804143917081, 9932.453715045598, 9963.651272205438, 13277.402516886763, 13353.933230333787, 13391.866081339256, 13403.597892063253, 13461.461541538425, 7130.465215108784, 7193.208747037822, 7254.0, 7304.342609165201, 7352.264773522712, 6990.510664253454, 6999.615021173782, 7003.299670033058, 7157.2127066022695, 7157.89263161053, 4009.3184158693093, 4019.588247051804, 4060.817263223162, 4091.2226676931286, 4138.358554424069, 1832.9826946044807, 1862.6926557118195, 1885.3495544037285, 1903.3528600275972, 1966.9311574094838, 1006.8942761009988, 1012.4937531234383, 1024.3085917005992, 1029.264076185531, 1030.5620111452602, 16683.49949501517, 17577.0, 17702.29190832378, 17739.37912173068, 18099.819001809814, 881.6517475597103, 909.8726178335038, 940.4498368454394, 986.6448078691665, 1019.1184625299063, 9765.9023409765, 9933.453660048623, 9983.101520863158, 10092.192624590016, 10093.142082923034, 400279.0, 400493.0, 405483.0, 406956.0, 408652.0, 46546.53453465422, 63263.0, 63479.36520634734, 78986.60506697545, 80723.0, 962.167724917941, 973.3284034016506, 985.4629227071264, 991.2763682511951, 991.3655260633201, 15458.84541154574, 15695.921520392325, 15779.36882524732, 15873.841261587237, 16118.758218626495, 34520.48219276763, 35845.46231806577, 36162.276754464234, 36296.63703363038, 38175.61824381832, 49278.0, 50493.74753126211, 50530.74734626451, 50671.0, 50879.23681144712, 7748.9612551939135, 7834.960825195838, 7877.448578599672, 7944.880826787718, 8011.439199255996, 8257.504549727035, 8464.915350846413, 8560.91439085601, 8562.100979397073, 8649.351298652751, 7443.627818609156, 7506.737264195727, 7796.337311328601, 7873.881891771743, 7922.027753840695, 7500.362469189961, 7679.308862202429, 7706.614669266626, 7714.228577142241, 8097.554634495159, 7814.492058016211, 7834.177411371724, 7986.041674999037, 8079.0, 8142.267195952156, 10841.783164336826, 11080.501377437873, 11506.654800356002, 11581.131415144066, 12091.637250882488, 11239.775204496027, 11340.829887551858, 11380.658580242605, 11387.715307117389, 11563.595274165364], "value": 8026.278660738376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.9630411087671, 1485.502356710502, 1511.8639322460979, 1681.9548984691821, 1837.9172937217816, 7032.613206273653, 7275.199728029919, 7335.413166946645, 7406.59263740494, 7436.628168591576, 7190.6404679766065, 7340.302671246223, 7355.154157271915, 7358.22738612446, 7373.705051797935, 1879.285871368878, 2157.0077764228395, 2169.8915054247304, 2199.2082850173924, 2254.785795349439, 2255.796978271955, 2261.118163916074, 2264.4338915271182, 2267.8979445924974, 2268.353519247015, 2183.6287831068676, 2236.7651396603364, 2242.159190303636, 2243.607368710477, 2245.719285089364, 1832.9266829326878, 2126.5002724359842, 2192.9451763705874, 2200.559888022386, 2201.6917631531596, 2210.469487323047, 2238.2725614175456, 2244.8540844845197, 2251.954960900789, 2314.884255787204, 7364.7790566282565, 7408.888866667005, 7414.6292685365515, 7415.88876166858, 7423.554586724814, 4492.146492166478, 4588.4952655208235, 4623.768811559408, 4627.8611641650805, 4657.04530571232, 2886.870090845917, 2898.6956369581103, 2919.7080291970633, 2933.2080338308538, 2963.2888106854416, 924.96300147994, 956.2588993530001, 968.4286271100085, 977.6529332087149, 991.6182269826169, 9491.905080949171, 9602.471864047475, 9725.173360264385, 9741.415515069048, 9825.950870245675, 4093.324601440729, 4160.355144952477, 4248.192843359751, 4264.232438161161, 4270.530241673413, 8369.539675317916, 8495.617697203641, 8519.74440766778, 8573.18554737299, 8588.098249683693, 4003.6997225208224, 4580.358749775034, 4584.404027476407, 4624.5375462453485, 4628.606568441653, 4046.4132700758223, 4149.2738770715005, 4176.60322269384, 4213.367994800743, 4213.557576454489, 3648.069742215771, 3660.066682995819, 3725.5715592706642, 3756.286305601927, 3787.0, 1168.684455197109, 1177.1171621284036, 1184.7808155491261, 1206.0291465370285, 1236.486857953939, 914.5107367558325, 914.5655813488672, 915.0666320353203, 928.4375124655998, 940.1632547033146, 5078.187490001582, 5115.437301896788, 5132.178851383761, 5175.948240517622, 5261.447548007404, 419.5888029730881, 426.1285670803215, 439.35414940038095, 439.984600538986, 441.8563966710832, 3613.223157021253, 3633.9636603634153, 3641.0, 3716.6840818530727, 3719.20037192005, 8785.428947118417, 8962.879640044994, 9022.368434209542, 9146.725598232064, 9169.449833010041, 8847.292216622654, 8956.193942545202, 8967.551622418852, 8973.057828927998, 9016.909830901606, 6431.163948686641, 6699.397054265042, 6883.0, 6968.3728464438445, 7017.89473157903, 5235.240890070994, 5282.867928301823, 5295.602829787705, 5371.0869152244995, 5381.784728610812, 7973.445178190197, 8068.9596552016865, 8232.135625759209, 8292.2951549119, 8306.916930830614, 8289.668413263644, 8290.212429819157, 8300.792480188044, 8350.206730360605, 8441.282490988335, 5968.641881487125, 6330.208723909512, 6539.247986481425, 6547.672616369257, 6640.800775976729, 7167.964160179165, 7184.928150718426, 7254.854902902018, 7257.0, 7260.927390726025, 6451.870962580816, 6510.283868774336, 6565.737370505318, 6620.867582648417, 6650.268470468148, 6506.804795856132, 6523.967380163259, 6555.082288479712, 6602.801915942529, 6675.766348177791, 6278.780242691667, 6311.905321420274, 6348.682565871595, 6360.141380913517, 6361.300256971637, 4375.628071613948, 4401.36180253855, 4483.910321793481, 4507.323901414683, 4522.321651752132, 4307.569243075667, 4407.889802754957, 4410.382546443565, 4416.955830441783, 4502.954970450384], "value": 3991.0904740773526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.72256691544527, 314.40734216002835, 321.8101320221069, 322.3826372496669, 324.2331885091759, 4842.443119041307, 4864.464908860023, 4864.781084851182, 4873.829415970442, 4898.387701537308, 4784.66507344486, 4804.231322988323, 4818.397700287455, 4822.276658501227, 4833.202521583943, 3869.2454971280613, 3882.941755873664, 3885.378339465693, 3899.9665088751362, 3912.2762288976487, 3771.7925514096714, 3858.6527212550864, 3875.360565506688, 3892.338302488584, 3892.9221415571674, 3773.490578771858, 3791.563970143441, 3798.5821559628557, 3819.847206111766, 3834.7699138051807, 3638.43604241343, 3817.8663746769007, 3822.1591249924973, 3824.368979118442, 3837.9232415351676, 3228.741700663941, 3364.9158771030675, 3385.492176173569, 3389.4237979543536, 3391.1522119470133, 4529.84145554904, 4557.156925968707, 4558.77206139695, 4565.977170114162, 4622.306654001893, 4107.527634322061, 4233.364995250707, 4333.674974376934, 4348.391225228471, 4371.584699453547, 5006.69959802413, 5010.974945125251, 5025.1708468102715, 5026.371703537058, 5043.268726034741, 3643.1802844360072, 3651.94522082169, 3655.94516082259, 3658.8536458541626, 3665.21197942441, 5040.180006428815, 5229.895402091937, 5249.212618107276, 5266.631335806495, 5284.180951952453, 3733.75730577517, 3733.962660373416, 3743.756655817363, 3745.9625403745613, 3766.3597188478025, 3830.9042273943373, 3847.1920896611464, 3850.114473671071, 3875.7286989910435, 3898.0, 4364.3851774843515, 4374.147041326911, 4385.890352741207, 4395.428594282723, 4409.536998615164, 4868.269759536098, 5028.849134525897, 5076.238564215398, 5092.337996060489, 5114.5652619527755, 1279.2772083772638, 1279.8144269081117, 1291.2245662214455, 1295.436485128972, 1307.8038294255937, 892.9374943754004, 909.7725568607848, 918.5223683684446, 925.5696101312922, 936.1481052242426, 4239.491261048694, 4243.68172387066, 4269.5516970718245, 4269.786510674454, 4295.72077814941, 4989.725565093882, 5018.698878067255, 5043.2435134730085, 5045.5459008689395, 5051.116054690415, 4267.551907049778, 4307.633851122627, 4310.633596144363, 4310.719803212781, 4311.827526898889, 2524.5203411351786, 2684.463107378532, 2686.9328266793095, 2695.2183866678442, 2696.393311504896, 4794.161021821167, 4819.855404337875, 4832.420109586872, 4833.3958255218095, 4843.975780121077, 4951.603871690256, 5099.64302498829, 5140.485951404829, 5206.7917283309, 5236.659617124875, 4863.635227357962, 4863.708177509361, 4866.513348665176, 4870.732109733999, 4877.0735559453815, 5029.899402012013, 5033.245013248042, 5074.847754567369, 5075.441701412916, 5097.490250974873, 4820.39745031871, 4986.301917731593, 5073.619478539198, 5084.440711521804, 5099.79600815978, 4898.975505122452, 4944.035912996931, 4945.727984960861, 4959.0, 4969.0, 3691.7231207658997, 3698.8176975584533, 3720.8697695580527, 3741.96258037427, 3743.326201283795, 5033.84898453047, 5287.0, 5297.496737809902, 5308.25684404176, 5334.226537152169, 5040.773165207501, 5043.646944713835, 5046.621503387334, 5052.520010598987, 5074.568661663652, 5043.193089105725, 5057.494250574913, 5062.835727670206, 5068.442471328225, 5074.644774865872, 4707.4351077869505, 4974.303597496426, 4997.775100120431, 4999.250112483157, 5002.624803139852, 4826.444958829639, 4929.728864912321, 5058.0, 5070.3155074064525, 5094.719790411563, 4977.253411988231, 4979.601631869514, 4982.900341993212, 4988.9501104988485, 4991.425986011655], "value": 3816.7303162651415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.5022460064058, 755.6221889055472, 800.6157044618581, 818.0551463060168, 824.32817253938, 11057.50241239144, 11795.882041179586, 12029.218100823462, 12058.698532536691, 12131.757364852709, 11973.940130299336, 12025.27848329101, 12108.334041627708, 12376.938115309433, 12399.69000774981, 872.9869051964209, 874.899386570543, 876.2508055612456, 876.2902049340023, 879.248242752447, 680.7243066558052, 696.568127760789, 855.102142750113, 873.388627960427, 878.4246318661287, 867.2411639815161, 867.9175478329548, 868.6221493650282, 869.5087275689247, 869.76516340588, 869.5956380283135, 870.1429092344099, 870.8171284030361, 871.525018864717, 871.8038441350709, 518.1062666899605, 657.644871769244, 672.132948496439, 672.3612568060362, 679.9558028728167, 11641.0, 11679.240849344766, 11681.299122052704, 11683.0, 11702.88297117035, 10551.366917984946, 10656.307340022873, 10758.354498730023, 10977.780444391148, 11144.973859610016, 10010.249231307609, 10112.646057387956, 10224.335418197794, 10365.74085647865, 10453.268271221017, 4040.113190686585, 4093.9590604093873, 4096.836126554934, 4120.793960301973, 4200.159968006411, 43096.3535546967, 43112.3533147003, 43114.35328470044, 43435.0, 43631.90920226988, 8751.212390884724, 8893.110688931056, 8894.59974301158, 8902.643894244287, 8980.191782739585, 16740.330386784637, 16776.748348774778, 16790.81719376473, 16814.075225862696, 16959.15204239783, 6055.515558755377, 6199.907001394983, 6351.872962540723, 6379.330170332141, 6404.103425520338, 3583.964160358415, 3636.0, 3639.1993761372455, 3667.9816600916824, 3689.3543629864666, 2836.1066264126734, 2923.9122826315242, 2929.5459203823443, 2929.6045033920573, 2934.823910565373, 565.0817421689754, 582.2954225387329, 588.6468119128574, 596.2397942623104, 600.7777122464717, 542.3464725006357, 559.2757379193954, 600.471799270848, 619.9101130336076, 649.0880313160018, 7559.979402780664, 7596.3922886168975, 7754.7673569793, 7882.684692612232, 7993.840123197503, 626.7868924565579, 626.8683576448997, 642.2966851297822, 650.6421468192475, 668.2682462703332, 3641.0715267606593, 3697.2605478904325, 3697.963020369762, 3803.6386543278345, 3916.80537436079, 52505.0, 52635.210471842955, 53417.732911335195, 54130.0, 54311.0, 48322.758386207846, 49460.258096128586, 49660.0, 50141.0, 51145.23282150771, 44010.33984490235, 44498.77750611226, 44701.77649111669, 44944.77527612341, 45068.0, 7376.889346659912, 7408.777736667908, 7446.664900079618, 7633.160352361125, 7654.770356889302, 30521.23696907595, 30870.845645772526, 30885.382292354476, 30992.0, 31156.0, 36561.81719091388, 37032.25935481329, 39612.80193599014, 39802.80098599489, 39894.40158397568, 9403.81192376135, 9613.134817866425, 9621.374610650286, 9725.902740972782, 9732.367396119229, 10485.0, 10694.89305106939, 10731.678049658523, 11058.944705276745, 11079.113670906469, 8271.958640207002, 10451.581936722447, 10749.301295415773, 10941.945290273497, 11230.0, 10753.731156721145, 10767.784644307227, 10823.56705731762, 10983.560657573607, 11125.833112503156, 10117.645882394081, 10120.89879101229, 10676.57293708243, 10746.516406761872, 10926.289791163548, 8922.86615700752, 9020.458772473672, 9067.546622668971, 9299.442033478013, 9322.580483878377, 9001.864972025294, 9025.232855207381, 9257.21313688344, 9617.903820961701, 9664.178544823768], "value": 5921.203080647629, "unit": "score"}], "name": "dromaeo_css", "value": 6288.967507315594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 116.0, 115.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 158.0, 210.0, 134.0, 166.0, 160.0, 132.0, 187.0, 132.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 163.0, 164.0, 161.0, 162.0, 162.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 152.0, 77.0, 76.0, 76.0, 76.0, 132.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 149.0, 92.0, 93.0, 94.0, 130.0, 93.0, 92.0, 124.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 81.0, 83.0, 83.0, 81.0, 141.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 140.0, 133.0, 135.0, 130.0, 132.0, 136.0, 150.0, 135.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 173.0, 172.0, 177.0, 174.0, 171.0, 173.0, 173.0, 172.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0, 66.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1581.7999999999997, "alertThreshold": 2.0}]} 04:40:22 INFO - Return code: 0 04:40:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:40:22 ERROR - # TBPL SUCCESS # 04:40:22 INFO - Running post-action listener: _resource_record_post_action 04:40:22 INFO - ##### 04:40:22 INFO - ##### Finished run-tests step (success) 04:40:22 INFO - ##### 04:40:22 INFO - Running post-run listener: _resource_record_post_run 04:40:23 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532189184; Read time: 12; Write time: 428140 04:40:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241291264; Read time: 0; Write time: 233012 04:40:23 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290897920; Read time: 12; Write time: 195128 04:40:23 INFO - Running post-run listener: _upload_blobber_files 04:40:23 INFO - Blob upload gear active. 04:40:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:23 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 04:40:23 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'] 04:40:23 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 04:40:23 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:24 INFO - (blobuploader) - INFO - Done attempting. 04:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:25 INFO - (blobuploader) - INFO - Done attempting. 04:40:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:25 INFO - Return code: 0 04:40:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e134c1754801fec138882f28ef51cf58ca04b278ec986e00e69c55185c5465451f27fc90808e18a50b19101609fc45fe7929888696a8f6a30f5d6da8b691125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80801aba4dba37d06d616b1f5c60cb68f786cae728ac371c343e44d8f7c037d7d2fde12b172a9d0141d4803e747af25cb2ab93661e8a093e82fa01f21a1094f9"} 04:40:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:25 INFO - Contents: 04:40:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e134c1754801fec138882f28ef51cf58ca04b278ec986e00e69c55185c5465451f27fc90808e18a50b19101609fc45fe7929888696a8f6a30f5d6da8b691125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80801aba4dba37d06d616b1f5c60cb68f786cae728ac371c343e44d8f7c037d7d2fde12b172a9d0141d4803e747af25cb2ab93661e8a093e82fa01f21a1094f9"} 04:40:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:25 INFO - Copying logs to upload dir... 04:40:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.115672 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-10 04:40:25.347792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 04:40:25.351084) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 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/7e134c1754801fec138882f28ef51cf58ca04b278ec986e00e69c55185c5465451f27fc90808e18a50b19101609fc45fe7929888696a8f6a30f5d6da8b691125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80801aba4dba37d06d616b1f5c60cb68f786cae728ac371c343e44d8f7c037d7d2fde12b172a9d0141d4803e747af25cb2ab93661e8a093e82fa01f21a1094f9"} build_url:https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/L1ezG45GS3eml_SeRmC10A/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/7e134c1754801fec138882f28ef51cf58ca04b278ec986e00e69c55185c5465451f27fc90808e18a50b19101609fc45fe7929888696a8f6a30f5d6da8b691125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80801aba4dba37d06d616b1f5c60cb68f786cae728ac371c343e44d8f7c037d7d2fde12b172a9d0141d4803e747af25cb2ab93661e8a093e82fa01f21a1094f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 04:40:25.375466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:40:25.375805) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462879184.265015-937262413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:40:25.460516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 04:40:25.460837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 04:40:25.461133) ========= ========= Total master_lag: 0.17 =========