builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1462879109.85 results: success (0) buildid: 20160510030406 builduid: 6b80c9eba73f4fc9a62005ceb48ee94e revision: 1522462dc6209910989b252fcfe307a9a0ddc281 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.845712) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.846310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.847024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.863395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.863667) ========= 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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 04:18:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.6M=0s 2016-05-10 04:18:30 (86.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.985724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:29.986035) ========= 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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:30.035255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:18:30.035587) ========= 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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 04:18:30,987 truncating revision to first 12 chars 2016-05-10 04:18:30,987 Setting DEBUG logging. 2016-05-10 04:18:30,987 attempt 1/10 2016-05-10 04:18:30,987 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:18:32,181 unpacking tar archive at: mozilla-central-1522462dc620/testing/mozharness/ program finished with exit code 0 elapsedTime=1.481931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:18:31.533801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:31.534597) ========= script_repo_revision: 1522462dc6209910989b252fcfe307a9a0ddc281 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:31.535546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:31.536187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:18:31.546263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-10 04:18:31.546983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:32 INFO - MultiFileLogger online at 20160510 04:18:32 in /builds/slave/test 04:18:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:18:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:32 INFO - {'append_to_log': False, 04:18:32 INFO - 'base_work_dir': '/builds/slave/test', 04:18:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:18:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:32 INFO - 'branch': 'Firefox-Non-PGO', 04:18:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:32 INFO - 'config_files': ('talos/linux_config.py',), 04:18:32 INFO - 'default_actions': ('clobber', 04:18:32 INFO - 'read-buildbot-config', 04:18:32 INFO - 'download-and-extract', 04:18:32 INFO - 'populate-webroot', 04:18:32 INFO - 'create-virtualenv', 04:18:32 INFO - 'install', 04:18:32 INFO - 'run-tests'), 04:18:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:32 INFO - 'download_minidump_stackwalk': True, 04:18:32 INFO - 'download_symbols': 'ondemand', 04:18:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:32 INFO - 'installer_path': 'installer.exe', 04:18:32 INFO - 'log_level': 'info', 04:18:32 INFO - 'log_name': 'talos', 04:18:32 INFO - 'log_to_console': True, 04:18:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:32 INFO - 'opt_config_files': (), 04:18:32 INFO - 'pip_index': False, 04:18:32 INFO - 'sps_profile': False, 04:18:32 INFO - 'sps_profile_interval': 0, 04:18:32 INFO - 'suite': 'dromaeojs-e10s', 04:18:32 INFO - 'system_bits': '32', 04:18:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:32 INFO - 'title': 'talos-linux64-ix-044', 04:18:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:32 INFO - 'use_talos_json': True, 04:18:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:32 INFO - 'work_dir': 'build'} 04:18:32 INFO - ##### 04:18:32 INFO - ##### Running clobber step. 04:18:32 INFO - ##### 04:18:32 INFO - Running pre-action listener: _resource_record_pre_action 04:18:32 INFO - Running main action method: clobber 04:18:32 INFO - rmtree: /builds/slave/test/build 04:18:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:33 INFO - Running post-action listener: _resource_record_post_action 04:18:33 INFO - ##### 04:18:33 INFO - ##### Finished clobber step (success) 04:18:33 INFO - ##### 04:18:33 INFO - ##### 04:18:33 INFO - ##### Running read-buildbot-config step. 04:18:33 INFO - ##### 04:18:33 INFO - Running pre-action listener: _resource_record_pre_action 04:18:33 INFO - Running main action method: read_buildbot_config 04:18:33 INFO - Using buildbot properties: 04:18:33 INFO - { 04:18:33 INFO - "project": "", 04:18:33 INFO - "product": "firefox", 04:18:33 INFO - "script_repo_revision": "production", 04:18:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:18:33 INFO - "repository": "", 04:18:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:18:33 INFO - "buildid": "20160510030406", 04:18:33 INFO - "pgo_build": "False", 04:18:33 INFO - "basedir": "/builds/slave/test", 04:18:33 INFO - "buildnumber": 308, 04:18:33 INFO - "slavename": "talos-linux64-ix-044", 04:18:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:18:33 INFO - "platform": "ubuntu64_hw", 04:18:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:18:33 INFO - "branch": "mozilla-central", 04:18:33 INFO - "repo_path": "mozilla-central", 04:18:33 INFO - "revision": "1522462dc6209910989b252fcfe307a9a0ddc281", 04:18:33 INFO - "stage_platform": "linux64", 04:18:33 INFO - "builduid": "6b80c9eba73f4fc9a62005ceb48ee94e", 04:18:33 INFO - "slavebuilddir": "test" 04:18:33 INFO - } 04:18:33 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:18:33 INFO - Running post-action listener: _resource_record_post_action 04:18:33 INFO - ##### 04:18:33 INFO - ##### Finished read-buildbot-config step (success) 04:18:33 INFO - ##### 04:18:33 INFO - ##### 04:18:33 INFO - ##### Running download-and-extract step. 04:18:33 INFO - ##### 04:18:33 INFO - Running pre-action listener: _resource_record_pre_action 04:18:33 INFO - Running main action method: download_and_extract 04:18:33 INFO - mkdir: /builds/slave/test/build/tests 04:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:34 INFO - Downloaded 1361 bytes. 04:18:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:34 INFO - Using the following test package requirements: 04:18:34 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:34 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:34 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:18:34 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'jsshell-linux-x86_64.zip'], 04:18:34 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:34 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:34 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:18:34 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:18:34 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:34 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:35 INFO - Downloaded 22322613 bytes. 04:18:35 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:18:35 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:18:36 INFO - Return code: 0 04:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:37 INFO - Downloaded 22322613 bytes. 04:18:37 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:18:37 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:18:39 INFO - Return code: 0 04:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:40 INFO - Downloaded 10840152 bytes. 04:18:40 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:18:40 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:18:40 INFO - Return code: 0 04:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:40 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:18:40 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:18:40 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:18:40 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:18:40 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:18:42 INFO - Downloaded 54859524 bytes. 04:18:42 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:18:42 INFO - mkdir: /builds/slave/test/properties 04:18:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:42 INFO - Contents: 04:18:42 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:18:43 INFO - Running post-action listener: _resource_record_post_action 04:18:43 INFO - Running post-action listener: set_extra_try_arguments 04:18:43 INFO - ##### 04:18:43 INFO - ##### Finished download-and-extract step (success) 04:18:43 INFO - ##### 04:18:43 INFO - ##### 04:18:43 INFO - ##### Running populate-webroot step. 04:18:43 INFO - ##### 04:18:43 INFO - Running pre-action listener: _resource_record_pre_action 04:18:43 INFO - Running main action method: populate_webroot 04:18:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:43 INFO - '--tppagecycles', 04:18:43 INFO - '7'], 04:18:43 INFO - 'tests': ['tsvgm']}}, 04:18:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:18:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:18:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['damp', 'tps']}, 04:18:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'tests': ['damp', 'tps']}, 04:18:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['dromaeo_dom']}, 04:18:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['a11yr', 04:18:43 INFO - 'ts_paint', 04:18:43 INFO - 'tpaint', 04:18:43 INFO - 'sessionrestore', 04:18:43 INFO - 'sessionrestore_no_auto_restore', 04:18:43 INFO - 'tabpaint']}, 04:18:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['tsvgx', 04:18:43 INFO - 'tsvgr_opacity', 04:18:43 INFO - 'tart', 04:18:43 INFO - 'tscrollx', 04:18:43 INFO - 'cart']}, 04:18:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:18:43 INFO - 'tsvgr_opacity', 04:18:43 INFO - 'tart', 04:18:43 INFO - 'tscrollx', 04:18:43 INFO - 'cart']}, 04:18:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'talos_options': ['--disable-e10s'], 04:18:43 INFO - 'tests': ['tp5o']}, 04:18:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'tests': ['tp5o']}, 04:18:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'talos_options': ['--disable-e10s', 04:18:43 INFO - '--xperf_path', 04:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:43 INFO - 'tests': ['tp5n']}, 04:18:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:43 INFO - 'talos_options': ['--xperf_path', 04:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:43 INFO - 'tests': ['tp5n']}}, 04:18:43 INFO - 'talos.zip': {'path': '', 04:18:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:43 INFO - Running post-action listener: _resource_record_post_action 04:18:43 INFO - ##### 04:18:43 INFO - ##### Finished populate-webroot step (success) 04:18:43 INFO - ##### 04:18:43 INFO - ##### 04:18:43 INFO - ##### Running create-virtualenv step. 04:18:43 INFO - ##### 04:18:43 INFO - Running pre-action listener: _resource_record_pre_action 04:18:43 INFO - Running main action method: create_virtualenv 04:18:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:43 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:18:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:43 INFO - Using real prefix '/usr' 04:18:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:46 INFO - Installing pip.................done. 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:46 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:18:46 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:18:46 INFO - Using env: {'DISPLAY': ':0', 04:18:46 INFO - 'HOME': '/home/cltbld', 04:18:46 INFO - 'LANG': 'en_US.UTF-8', 04:18:46 INFO - 'LANGUAGE': 'en_US:en', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MAIL': '/var/mail/cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SHLVL': '1', 04:18:46 INFO - 'TERM': 'linux', 04:18:46 INFO - 'TMOUT': '86400', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - '_': '/tools/buildbot/bin/python'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 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:18:46 INFO - Cleaning up... 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:46 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:18:46 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:18:46 INFO - Using env: {'DISPLAY': ':0', 04:18:46 INFO - 'HOME': '/home/cltbld', 04:18:46 INFO - 'LANG': 'en_US.UTF-8', 04:18:46 INFO - 'LANGUAGE': 'en_US:en', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MAIL': '/var/mail/cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SHLVL': '1', 04:18:46 INFO - 'TERM': 'linux', 04:18:46 INFO - 'TMOUT': '86400', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - '_': '/tools/buildbot/bin/python'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 INFO - Downloading/unpacking psutil>=0.7.1 04:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:48 INFO - Installing collected packages: psutil 04:18:48 INFO - Running setup.py install for psutil 04:18:48 INFO - building 'psutil._psutil_linux' extension 04:18:48 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:18:48 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:18:49 INFO - building 'psutil._psutil_posix' extension 04:18:49 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:18:49 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:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:49 INFO - Successfully installed psutil 04:18:49 INFO - Cleaning up... 04:18:49 INFO - Return code: 0 04:18:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:18:49 INFO - Using env: {'DISPLAY': ':0', 04:18:49 INFO - 'HOME': '/home/cltbld', 04:18:49 INFO - 'LANG': 'en_US.UTF-8', 04:18:49 INFO - 'LANGUAGE': 'en_US:en', 04:18:49 INFO - 'LOGNAME': 'cltbld', 04:18:49 INFO - 'MAIL': '/var/mail/cltbld', 04:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:49 INFO - 'MOZ_NO_REMOTE': '1', 04:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:49 INFO - 'NO_EM_RESTART': '1', 04:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:49 INFO - 'PWD': '/builds/slave/test', 04:18:49 INFO - 'SHELL': '/bin/bash', 04:18:49 INFO - 'SHLVL': '1', 04:18:49 INFO - 'TERM': 'linux', 04:18:49 INFO - 'TMOUT': '86400', 04:18:49 INFO - 'USER': 'cltbld', 04:18:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:49 INFO - '_': '/tools/buildbot/bin/python'} 04:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:51 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:18:51 INFO - Installing collected packages: mozsystemmonitor 04:18:51 INFO - Running setup.py install for mozsystemmonitor 04:18:51 INFO - Successfully installed mozsystemmonitor 04:18:51 INFO - Cleaning up... 04:18:51 INFO - Return code: 0 04:18:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:18:51 INFO - Using env: {'DISPLAY': ':0', 04:18:51 INFO - 'HOME': '/home/cltbld', 04:18:51 INFO - 'LANG': 'en_US.UTF-8', 04:18:51 INFO - 'LANGUAGE': 'en_US:en', 04:18:51 INFO - 'LOGNAME': 'cltbld', 04:18:51 INFO - 'MAIL': '/var/mail/cltbld', 04:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:51 INFO - 'MOZ_NO_REMOTE': '1', 04:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:51 INFO - 'NO_EM_RESTART': '1', 04:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:51 INFO - 'PWD': '/builds/slave/test', 04:18:51 INFO - 'SHELL': '/bin/bash', 04:18:51 INFO - 'SHLVL': '1', 04:18:51 INFO - 'TERM': 'linux', 04:18:51 INFO - 'TMOUT': '86400', 04:18:51 INFO - 'USER': 'cltbld', 04:18:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:51 INFO - '_': '/tools/buildbot/bin/python'} 04:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:54 INFO - Downloading docopt-0.6.1.tar.gz 04:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:54 INFO - Running setup.py install for blobuploader 04:18:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:54 INFO - Running setup.py install for requests 04:18:54 INFO - Running setup.py install for docopt 04:18:54 INFO - Successfully installed blobuploader requests docopt 04:18:54 INFO - Cleaning up... 04:18:55 INFO - Return code: 0 04:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:55 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:18:55 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:18:55 INFO - Using env: {'DISPLAY': ':0', 04:18:55 INFO - 'HOME': '/home/cltbld', 04:18:55 INFO - 'LANG': 'en_US.UTF-8', 04:18:55 INFO - 'LANGUAGE': 'en_US:en', 04:18:55 INFO - 'LOGNAME': 'cltbld', 04:18:55 INFO - 'MAIL': '/var/mail/cltbld', 04:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:55 INFO - 'MOZ_NO_REMOTE': '1', 04:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:55 INFO - 'NO_EM_RESTART': '1', 04:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:55 INFO - 'PWD': '/builds/slave/test', 04:18:55 INFO - 'SHELL': '/bin/bash', 04:18:55 INFO - 'SHLVL': '1', 04:18:55 INFO - 'TERM': 'linux', 04:18:55 INFO - 'TMOUT': '86400', 04:18:55 INFO - 'USER': 'cltbld', 04:18:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:55 INFO - '_': '/tools/buildbot/bin/python'} 04:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:55 INFO - Running setup.py (path:/tmp/pip-S279wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:55 INFO - Running setup.py (path:/tmp/pip-FTjvjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:55 INFO - Running setup.py (path:/tmp/pip-RDoCds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:55 INFO - Running setup.py (path:/tmp/pip-qx24r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:55 INFO - Running setup.py (path:/tmp/pip-zkWvTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:55 INFO - Running setup.py (path:/tmp/pip-BhHe62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:55 INFO - Running setup.py (path:/tmp/pip-KQGN0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:55 INFO - Running setup.py (path:/tmp/pip-ht8JW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:55 INFO - Running setup.py (path:/tmp/pip-QdtMXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:55 INFO - Running setup.py (path:/tmp/pip-Yx4aEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:55 INFO - Running setup.py (path:/tmp/pip-XsKDdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:56 INFO - Running setup.py (path:/tmp/pip-wHfuOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:56 INFO - Running setup.py (path:/tmp/pip-_PYJgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:56 INFO - Running setup.py (path:/tmp/pip-h4zsNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:56 INFO - Running setup.py (path:/tmp/pip-J8h7FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:56 INFO - Running setup.py (path:/tmp/pip-hmpP_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:56 INFO - Running setup.py (path:/tmp/pip-bg0r8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:56 INFO - Running setup.py install for manifestparser 04:18:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:56 INFO - Running setup.py install for mozcrash 04:18:56 INFO - Running setup.py install for mozdebug 04:18:56 INFO - Running setup.py install for mozdevice 04:18:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:56 INFO - Running setup.py install for mozfile 04:18:56 INFO - Running setup.py install for mozhttpd 04:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozinfo 04:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozInstall 04:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozleak 04:18:57 INFO - Running setup.py install for mozlog 04:18:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for moznetwork 04:18:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozprocess 04:18:57 INFO - Running setup.py install for mozprofile 04:18:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozrunner 04:18:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:57 INFO - Running setup.py install for mozscreenshot 04:18:58 INFO - Running setup.py install for moztest 04:18:58 INFO - Running setup.py install for mozversion 04:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:58 INFO - Cleaning up... 04:18:58 INFO - Return code: 0 04:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:58 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:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:58 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:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:58 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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:18:58 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:18:58 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:18:58 INFO - Using env: {'DISPLAY': ':0', 04:18:58 INFO - 'HOME': '/home/cltbld', 04:18:58 INFO - 'LANG': 'en_US.UTF-8', 04:18:58 INFO - 'LANGUAGE': 'en_US:en', 04:18:58 INFO - 'LOGNAME': 'cltbld', 04:18:58 INFO - 'MAIL': '/var/mail/cltbld', 04:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:58 INFO - 'MOZ_NO_REMOTE': '1', 04:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:58 INFO - 'NO_EM_RESTART': '1', 04:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:58 INFO - 'PWD': '/builds/slave/test', 04:18:58 INFO - 'SHELL': '/bin/bash', 04:18:58 INFO - 'SHLVL': '1', 04:18:58 INFO - 'TERM': 'linux', 04:18:58 INFO - 'TMOUT': '86400', 04:18:58 INFO - 'USER': 'cltbld', 04:18:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:58 INFO - '_': '/tools/buildbot/bin/python'} 04:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:58 INFO - Running setup.py (path:/tmp/pip-agJPUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:58 INFO - Running setup.py (path:/tmp/pip-0QzRwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:58 INFO - Running setup.py (path:/tmp/pip-T_JJi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:58 INFO - Running setup.py (path:/tmp/pip-lnNkZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:58 INFO - Running setup.py (path:/tmp/pip-wFvG2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:58 INFO - Running setup.py (path:/tmp/pip-CnX_ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:58 INFO - Running setup.py (path:/tmp/pip-8QKt3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:58 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:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:58 INFO - Running setup.py (path:/tmp/pip-IX6bIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:59 INFO - Running setup.py (path:/tmp/pip-6Mxv_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:59 INFO - Running setup.py (path:/tmp/pip-5F4_Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:59 INFO - Running setup.py (path:/tmp/pip-qjNkRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:59 INFO - Running setup.py (path:/tmp/pip-QBpLRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:59 INFO - Running setup.py (path:/tmp/pip-dI4YRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:59 INFO - Running setup.py (path:/tmp/pip-p2HA0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:59 INFO - Running setup.py (path:/tmp/pip-yvpNXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:59 INFO - Running setup.py (path:/tmp/pip-F2xYy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:59 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:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:59 INFO - Running setup.py (path:/tmp/pip-6kYm9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 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:18:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:01 INFO - Downloading blessings-1.6.tar.gz 04:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:01 INFO - Installing collected packages: blessings 04:19:01 INFO - Running setup.py install for blessings 04:19:01 INFO - Successfully installed blessings 04:19:01 INFO - Cleaning up... 04:19:01 INFO - Return code: 0 04:19:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:02 INFO - Reading from file tmpfile_stdout 04:19:02 INFO - Current package versions: 04:19:02 INFO - argparse == 1.2.1 04:19:02 INFO - blessings == 1.6 04:19:02 INFO - blobuploader == 1.2.4 04:19:02 INFO - docopt == 0.6.1 04:19:02 INFO - manifestparser == 1.1 04:19:02 INFO - mozInstall == 1.12 04:19:02 INFO - mozcrash == 0.17 04:19:02 INFO - mozdebug == 0.1 04:19:02 INFO - mozdevice == 0.48 04:19:02 INFO - mozfile == 1.2 04:19:02 INFO - mozhttpd == 0.7 04:19:02 INFO - mozinfo == 0.9 04:19:02 INFO - mozleak == 0.1 04:19:02 INFO - mozlog == 3.1 04:19:02 INFO - moznetwork == 0.27 04:19:02 INFO - mozprocess == 0.22 04:19:02 INFO - mozprofile == 0.28 04:19:02 INFO - mozrunner == 6.11 04:19:02 INFO - mozscreenshot == 0.1 04:19:02 INFO - mozsystemmonitor == 0.0 04:19:02 INFO - moztest == 0.7 04:19:02 INFO - mozversion == 1.4 04:19:02 INFO - psutil == 3.1.1 04:19:02 INFO - requests == 1.2.3 04:19:02 INFO - wsgiref == 0.1.2 04:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19: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:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:02 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 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:02 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:19:02 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:19:02 INFO - Using env: {'DISPLAY': ':0', 04:19:02 INFO - 'HOME': '/home/cltbld', 04:19:02 INFO - 'LANG': 'en_US.UTF-8', 04:19:02 INFO - 'LANGUAGE': 'en_US:en', 04:19:02 INFO - 'LOGNAME': 'cltbld', 04:19:02 INFO - 'MAIL': '/var/mail/cltbld', 04:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:02 INFO - 'MOZ_NO_REMOTE': '1', 04:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:02 INFO - 'NO_EM_RESTART': '1', 04:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:02 INFO - 'PWD': '/builds/slave/test', 04:19:02 INFO - 'SHELL': '/bin/bash', 04:19:02 INFO - 'SHLVL': '1', 04:19:02 INFO - 'TERM': 'linux', 04:19:02 INFO - 'TMOUT': '86400', 04:19:02 INFO - 'USER': 'cltbld', 04:19:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:02 INFO - '_': '/tools/buildbot/bin/python'} 04:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 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:19:02 INFO - Cleaning up... 04:19:02 INFO - Return code: 0 04:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19: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:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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: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', 'jsonschema'] in /builds/slave/test/build 04:19: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 jsonschema 04:19:02 INFO - Using env: {'DISPLAY': ':0', 04:19:02 INFO - 'HOME': '/home/cltbld', 04:19:02 INFO - 'LANG': 'en_US.UTF-8', 04:19:02 INFO - 'LANGUAGE': 'en_US:en', 04:19:02 INFO - 'LOGNAME': 'cltbld', 04:19:02 INFO - 'MAIL': '/var/mail/cltbld', 04:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:02 INFO - 'MOZ_NO_REMOTE': '1', 04:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:02 INFO - 'NO_EM_RESTART': '1', 04:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:02 INFO - 'PWD': '/builds/slave/test', 04:19:02 INFO - 'SHELL': '/bin/bash', 04:19:02 INFO - 'SHLVL': '1', 04:19:02 INFO - 'TERM': 'linux', 04:19:02 INFO - 'TMOUT': '86400', 04:19:02 INFO - 'USER': 'cltbld', 04:19:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:02 INFO - '_': '/tools/buildbot/bin/python'} 04:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:02 INFO - Downloading/unpacking jsonschema 04:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:04 INFO - warning: no files found matching '*.txt' 04:19:04 INFO - no previously-included directories found matching 'build' 04:19:04 INFO - no previously-included directories found matching 'dist' 04:19:04 INFO - no previously-included directories found matching '.git*' 04:19:04 INFO - Installing collected packages: jsonschema, functools32 04:19:04 INFO - Running setup.py install for functools32 04:19:04 INFO - warning: no files found matching '*.txt' 04:19:04 INFO - no previously-included directories found matching 'build' 04:19:04 INFO - no previously-included directories found matching 'dist' 04:19:04 INFO - no previously-included directories found matching '.git*' 04:19:04 INFO - Successfully installed jsonschema functools32 04:19:04 INFO - Cleaning up... 04:19:04 INFO - Return code: 0 04:19:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:19:04 INFO - Using env: {'DISPLAY': ':0', 04:19:04 INFO - 'HOME': '/home/cltbld', 04:19:04 INFO - 'LANG': 'en_US.UTF-8', 04:19:04 INFO - 'LANGUAGE': 'en_US:en', 04:19:04 INFO - 'LOGNAME': 'cltbld', 04:19:04 INFO - 'MAIL': '/var/mail/cltbld', 04:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:04 INFO - 'MOZ_NO_REMOTE': '1', 04:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:04 INFO - 'NO_EM_RESTART': '1', 04:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:04 INFO - 'PWD': '/builds/slave/test', 04:19:04 INFO - 'SHELL': '/bin/bash', 04:19:04 INFO - 'SHLVL': '1', 04:19:04 INFO - 'TERM': 'linux', 04:19:04 INFO - 'TMOUT': '86400', 04:19:04 INFO - 'USER': 'cltbld', 04:19:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:04 INFO - '_': '/tools/buildbot/bin/python'} 04:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:05 INFO - Downloading/unpacking flake8 04:19: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:19: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:19: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:19: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:19: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:19: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:19:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:19:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:19:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:19: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:19: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:19: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:19: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:19: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:19: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:19:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:19: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:19: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:19: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:19: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:19: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:19: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:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:07 INFO - no previously-included directories found matching 'docs/_build' 04:19:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:19:07 INFO - Running setup.py install for pep8 04:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:07 INFO - no previously-included directories found matching 'docs/_build' 04:19:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:19:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:19:07 INFO - Cleaning up... 04:19:07 INFO - Return code: 0 04:19:07 INFO - Running post-action listener: _resource_record_post_action 04:19:07 INFO - Running post-action listener: _start_resource_monitoring 04:19:07 INFO - Starting resource monitoring. 04:19:07 INFO - ##### 04:19:07 INFO - ##### Finished create-virtualenv step (success) 04:19:07 INFO - ##### 04:19:07 INFO - ##### 04:19:07 INFO - ##### Running install step. 04:19:07 INFO - ##### 04:19:07 INFO - Running pre-action listener: _resource_record_pre_action 04:19:07 INFO - Running main action method: install 04:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:08 INFO - Reading from file tmpfile_stdout 04:19:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:08 INFO - Reading from file tmpfile_stdout 04:19:08 INFO - Output received: 04:19:08 INFO - Usage: mozinstall [options] installer 04:19:08 INFO - Options: 04:19:08 INFO - -h, --help show this help message and exit 04:19:08 INFO - -d DEST, --destination=DEST 04:19:08 INFO - Directory to install application into. [default: 04:19:08 INFO - "/builds/slave/test"] 04:19:08 INFO - --app=APP Application being installed. [default: firefox] 04:19:08 INFO - mkdir: /builds/slave/test/build/application 04:19:08 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:19:08 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:19:24 INFO - Reading from file tmpfile_stdout 04:19:24 INFO - Output received: 04:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:19:24 INFO - Running post-action listener: _resource_record_post_action 04:19:24 INFO - ##### 04:19:24 INFO - ##### Finished install step (success) 04:19:24 INFO - ##### 04:19:24 INFO - ##### 04:19:24 INFO - ##### Running run-tests step. 04:19:24 INFO - ##### 04:19:24 INFO - Running pre-action listener: _resource_record_pre_action 04:19:24 INFO - Running main action method: run_tests 04:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:19:24 INFO - Python 2.7.3 04:19:24 INFO - Return code: 0 04:19:24 INFO - grabbing minidump binary from tooltool 04:19:24 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:24 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 0xec79c0>, '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 0xec88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:19:24 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:19:24 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:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:24 INFO - Return code: 0 04:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:19:25 INFO - Return code: 0 04:19:25 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-e10s', '--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-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:19:25 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-e10s --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-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:19:25 INFO - Using env: {'DISPLAY': ':0', 04:19:25 INFO - 'HOME': '/home/cltbld', 04:19:25 INFO - 'LANG': 'en_US.UTF-8', 04:19:25 INFO - 'LANGUAGE': 'en_US:en', 04:19:25 INFO - 'LOGNAME': 'cltbld', 04:19:25 INFO - 'MAIL': '/var/mail/cltbld', 04:19:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:25 INFO - 'MOZ_NO_REMOTE': '1', 04:19:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:25 INFO - 'NO_EM_RESTART': '1', 04:19:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:25 INFO - 'PWD': '/builds/slave/test', 04:19:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:25 INFO - 'SHELL': '/bin/bash', 04:19:25 INFO - 'SHLVL': '1', 04:19:25 INFO - 'TERM': 'linux', 04:19:25 INFO - 'TMOUT': '86400', 04:19:25 INFO - 'USER': 'cltbld', 04:19:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820', 04:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:25 INFO - '_': '/tools/buildbot/bin/python'} 04:19:25 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-e10s', '--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-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:19:25 INFO - mozversion application_buildid: 20160510030406 04:19:25 INFO - mozversion application_changeset: 1522462dc6209910989b252fcfe307a9a0ddc281 04:19:25 INFO - mozversion application_display_name: Nightly 04:19:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:25 INFO - mozversion application_name: Firefox 04:19:25 INFO - mozversion application_remotingname: firefox 04:19:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:19:25 INFO - mozversion application_vendor: Mozilla 04:19:25 INFO - mozversion application_version: 49.0a1 04:19:25 INFO - mozversion platform_buildid: 20160510030406 04:19:25 INFO - mozversion platform_changeset: 1522462dc6209910989b252fcfe307a9a0ddc281 04:19:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:19:25 INFO - mozversion platform_version: 49.0a1 04:19:25 INFO - using testdate: 1462879165 04:19:25 INFO - actual date: 1462879165 04:19:25 INFO - starting webserver on 'localhost:33292' 04:19:25 INFO - SUITE-START | Running 2 tests 04:19:25 INFO - TEST-START | dromaeo_css 04:19:25 INFO - operating with platform_type : linux_ 04:19:25 INFO - Initialising browser for dromaeo_css test... 04:19:25 INFO - TEST-INFO | started process 16403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaKp7ws/profile http://localhost:33292/getInfo.html) 04:19:29 INFO - PROCESS | 16403 | 04:19:29 INFO - PROCESS | 16403 | (process:16470): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:30 INFO - PROCESS | 16403 | __metrics Screen width/height:1600/1200 04:19:30 INFO - PROCESS | 16403 | colorDepth:24 04:19:30 INFO - PROCESS | 16403 | Browser inner width/height: 1024/697 04:19:30 INFO - PROCESS | 16403 | __metrics 04:19:30 ERROR - PROCESS | 16403 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:19:31 INFO - TEST-INFO | 16403: exit 0 04:19:31 INFO - Browser initialized. 04:19:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:31 INFO - TEST-INFO | started process 16521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaKp7ws/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:33 INFO - PROCESS | 16521 | 04:19:33 INFO - PROCESS | 16521 | (process:16582): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:43 INFO - PROCESS | 16521 | RSS: Main: 164622336 04:19:43 INFO - PROCESS | 16521 | 04:20:33 INFO - PROCESS | 16521 | 1462879233244 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:22:45 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33292/tests/dromaeo/cssquery-ext.html) 04:22:46 INFO - PROCESS | 16521 | RSS: Main: 166293504 04:22:46 INFO - PROCESS | 16521 | 04:25:48 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-ext.html (next: http://localhost:33292/tests/dromaeo/cssquery-jquery.html) 04:25:49 INFO - PROCESS | 16521 | RSS: Main: 165584896 04:25:49 INFO - PROCESS | 16521 | 04:28:51 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33292/tests/dromaeo/cssquery-mootools.html) 04:28:51 INFO - PROCESS | 16521 | RSS: Main: 166453248 04:28:51 INFO - PROCESS | 16521 | 04:31:53 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33292/tests/dromaeo/cssquery-prototype.html) 04:31:54 INFO - PROCESS | 16521 | RSS: Main: 164364288 04:31:54 INFO - PROCESS | 16521 | 04:34:56 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33292/tests/dromaeo/cssquery-yui.html) 04:34:57 INFO - PROCESS | 16521 | RSS: Main: 165666816 04:34:57 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:33292/tests/dromaeo/cssquery-yui.html (next: http://localhost:33292/tests/dromaeo/cssquery-dojo.html) 04:38:00 INFO - PROCESS | 16521 | RSS: Main: 167759872 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | __start_tp_report 04:38:00 INFO - PROCESS | 16521 | _x_x_mozilla_page_load 04:38:00 INFO - PROCESS | 16521 | _x_x_mozilla_page_load_details 04:38:00 INFO - PROCESS | 16521 | |i|pagename|runs| 04:38:00 INFO - PROCESS | 16521 | |0;dojo.html;2651.907183248586;2716.388812517184;2735.6443662323895;2737.069396405222;2752.5871119332096;4772.379590653214;4794.544518270763;4798.592119669828;4875.07373599016;4955.876103097416;4751.311059896321;4820.783064762085;4845.58812500937;4862.465128835825;4902.289168070628;4392.802323895425;4519.728816271017;4547.340635607835;4581.862544123682;4613.6539759518;4481;4543.204939135655;4545.022820093679;4551.044280701057;4556.772161391934;4403.383526306319;4425.623821975136;4446.955530444687;4452.220861349251;4500.932486012713;4459.464864216282;4467.441569803775;4476.910461790779;4486.663500237462;4507.616852567536;4492.326151077332;4515.525869783658;4519.028408892104;4532.161550113239;4555.544445555418;4726.054789042171;4752.904941901177;4787.784549695272;4788.832390866338;4793.808247670089;5217.191335343028;5228.163493840967;5231.581473482112;5242.895142097175;5284.603654725911;4973.95546935144;5280.313559237313;5291.444398338158;5291.656042357235;5305.177697456862;4842.1526232909455;4876.829310974099;4880.560749532524;4888.071266459361;4899.2896030075435;5302.973485132627;5337.919931201035;5348.3849357323625;5353.0899747043095;5387.353517577837;4839.395075615548;5069.797208111708;5108.66793658411;5122.769475373617;5138.511841375063;5193.636445448782;5229.764660590283;5250.028744682246;5251.264822924793;5302.681839089667;5018.673786203885;5152.227165925141;5162.97418512905;5213.035588416155;5232.372115346183;5007.023630392038;5143.3570803649545;5204.843854684365;5208.218767184877;5208.244804503402;4437.534058923831;4491.842785502492;4492.528284530143;4534.410526631583;4538.977305113453;3871.4192871069004;3877.4377715231135;3879.127196380848;3899.6490315871706;3923.9019024524614;4325.740455572675;4385.473743150778;4432.911341773147;4450.821967121344;4525.728456292633;5175.7153356564995;5190.688558686491;5212.374515058217;5217.739113044333;5252.579793616502;4426.336049592523;4434.866953991385;4444.1333939881415;4473.015936493966;4479.955200448019;4607.193741095295;4673.275642275453;4678.3216433616935;4693.906121877543;4709.811607535728;4890.07088653169;4898.706077635354;4900.240462728283;4908.116539022939;4946.554810067111;5195.272661827423;5213.244079608511;5214.608904332114;5215.817446389358;5231.633785634969;4802.207635740064;4809.422869255712;4827.951720482891;4848.539388758062;4864.975675121602;5087.160618498055;5094.617903657167;5095.541401273903;5121.103806833864;5163.509466600667;5172.870678233075;5183.792648294026;5196.4283928767045;5232.26748255237;5282.445343239058;4893.535114164149;4917.704937703749;5131;5145.4340022598235;5170.793168273377;4928.285398617252;4984.028114517634;5012.997400519984;5037.420696619789;5045.394552653705;4947.554720075211;4996.475370086088;5006.7246301452315;5017.071841709296;5062.721550314768;4882.536159064884;5079.695218286767;5095.847124586268;5112.335396398445;5126.53861152498;4980.726060066731;4981.37732783402;4998.525140111684;5042.042012017705;5078.035173317206 04:38:00 INFO - PROCESS | 16521 | |1;ext.html;587.9123621300595;607.3107023528297;613.2181468627499;625.6871564217892;635.0474288567151;35579.11052223692;39803.60196398035;40010.59989400109;40043.1991360173;40048.39927401084;40185.59814401855;40761.79619101908;40785;40908.181836363256;40942.18115637686;7827.1781462946565;7936.24605662464;7938.6427610757655;7969.242921922408;7979.441439099265;7852.528848269094;7964.084130325029;7966.6813327467125;7999.36005119589;8015;8000.359971202319;8024.558649274288;8030.277275045245;8040.276375126237;8052.718154864581;7945.165757595456;7952.204779522031;7980.082290536576;8003.95998020012;8035.638396272182;7838.333741631911;7848.882266766003;7906.248906353945;7915.722949696733;7923.286904178652;30586.38827223443;37610.05974850623;37730.62269377326;37959.81020094882;38020.61979380198;3189.346184032268;3348.1796959744775;3377.3245350929665;3876.8061596920043;4120.546739858643;27912.86043569769;31370.21574460657;31571;32640.510392344135;34987;3278.606567211926;3299.1257316811066;3328.9500657490157;3346.113279980807;3347.7991320520846;245345;250280.99999999817;250824;251502;251707;61970.69014654898;62031;62539;62649.68675156595;62754;36512.634873650924;37599.62400376016;37617.81191094027;64273.35726642767;64474.355256446834;13501.59495215145;13680.247586382844;13721.108127971649;13725.382357793724;13808.378622961991;10023.69928902134;10149.695509134737;10198.490075496196;10205.285630005978;10253.84619230712;19767.604647906963;19842.50393740168;20166.39500814978;20256.392308230777;20279.59440811205;7751.612419379008;7961.681532738626;8079.272865442138;8087.353011759045;8100.149484304063;923.7459698582943;1018.2261481274285;1031.5203430404897;1035.7203555040096;1095.2606990281529;29617.85191074074;29684.554731679043;29969.550456743167;30242.697573024427;30273.24316892095;1021.7598864266891;1022.0188618925766;1048.339546085961;1053.773438710681;1168.1881092640704;15581.610459738597;15917.930669012954;16047.598810029842;16053.598660033593;16355.182240887909;374854;377235;380486;381023;382330;51748;52171.73914130481;52331.215031774555;52471.47528524742;52569;1249.6188662458037;1261.7413430246777;1270.7140893299118;1280.2894393611634;1287.587971849018;27905.16284511468;29044.419111617226;29174.854125729235;29232.559867263633;29869.253268668457;43606.56393436025;45194.54805451904;45389.773051134536;45470.54529454663;45584.316235255836;322661;325769;325972;326058;327500;26823.329416764736;27073.729262707122;27133;27153.59269610997;27222;44321.778391109125;45037;45480.772596136805;45732.08535829331;46090;38131.046723831016;38690.41964370593;38816.6118338813;40011.79994100011;40089;37822;38314.80842595769;39854.80072599618;40287;41958;33356.66643333633;39082.6091739079;39202.41196381999;39526.60473395229;39579.80210098931;34520.30959380849;35202.29595408129;35314.82342588271;35496.46755298621;35804;26299.73700262973;26448.7355126454;26821.463570728865;26950.085215487758;27414.45171096527 04:38:00 INFO - PROCESS | 16521 | |2;jquery.html;376.3132283582462;378.9450529673197;380.8647929984857;387;395.30229145558076;16148;16584.917075414636;17462.30150793967;17465.214065367058;17537.736933946002;10489.947550262257;16044.11757353348;16910.577235569115;16924.323027078903;17496.668721783593;4468.218061839189;4582.450105987286;4637.814487420499;4639.211334073216;4656.813727450898;3497.090756403328;5157.174852023677;5473.972630136844;5487.42382049883;5544.972275138619;5440.173512483657;5464.23500709901;5481.397046324901;5532.336119665646;5538.9169162462595;5300.628955973083;5443.237946687467;5455.454454554552;5457.154141108134;5463.016657001758;4622.537746225385;5302.045631786277;5308.124159513675;5309.203619457074;5309.203619457112;11045.39250341231;11129.777404451866;11207.719807004809;11209.831852522218;11223.66329010131;1941.3011315926256;2024.595080983809;2071.85497015209;2092.7157584976285;2158.4493508178957;8815.382923195379;8858.789424745535;8965.372423930328;8979.057198994142;9595.23238140954;1754.2193723792918;1791.4536066499713;1809.6923523001121;1834.5230240137528;1859.711744679577;69782;72695;72721.63639181823;72882.63558682226;73053.63473182653;9460.810783784424;9553.761155971017;9865.950670246602;10127.088562029452;10520.210984176218;14532.27338633064;14670.926645366704;14686.41254349814;14689.118652880861;14782.926085369505;7072.292770722989;7099;7180.7845764627145;7263.6005019724425;7287.417006639562;6319.33646967071;6328.050792381087;6419.51853610981;6499.252585952581;6642.335766423319;4384.649228061748;4432.867013989586;4515.458145022552;4580.175568397721;4624.375709279204;1611.2668735725217;1731.2555601091399;1756.604763928106;1772.4328214971342;1796.3712700554963;888.4225253585092;913.2237598041611;981.8527220916919;1026.7535791410157;1065.248999455382;16528;16661.6667666646;16693.99836009819;17091.48725538236;17111.65776684484;953.1755031897359;957.4207604399378;973.3089506450358;979.4710856137606;985.9408435493893;9450.196733277748;9484.383515071499;9502.239820814319;9623.52637893262;9644.373115747454;408105;417767;418160;420694;420933;51129.74435127875;74219.25780742231;76648;77468.22531774723;79798;917.1058218237299;935.0649350649351;944.3719926249105;962.3119469579284;967.327707243459;14973.401063957755;15019.32413041394;15156.24218789034;15209.847901521285;15385.461508847136;34216.82891585526;35350.46974295439;36257.45613815848;36327.81836090803;36426.81786591156;48538.27192592184;49028;49562.50437495579;49849;49906.75046624744;6646.667666616747;7085.468589855678;7241.312075352833;7448.553086814808;7557.470977031555;9049.909500904907;11386.829197562209;11462.369569673749;12046.879531204575;12260.816087758512;10492.422916739653;10656.413897235416;10662.946685266525;10830.133589312678;10989.010989011027;10265.281430299807;10449.63426280107;10646.627368042082;10749.677509674722;10844.18668599874;5643.802466913638;7928.524288542706;10498.265121441425;10638.627648032281;10684.83972740394;7956.84086318282;7993.520388776692;8020.157883422156;8195.344372450309;8232.62953167097;9549.856752148584;10485.423301718478;10504;10659.733506662396;10881.673549793202 04:38:00 INFO - PROCESS | 16521 | |3;mootools.html;1477.5271912987844;1527.8854085943556;1669.6076422040826;1797.541626885145;1814.2561549764598;6489.480841532678;7103.289671032894;7134;7614.086309642844;7627.237276272377;7083.291670832914;7326.010988516548;7377.741779037735;7380.852382952337;7391.445641576876;2144.313819577732;2172.6849606807004;2172.73927128744;2179.5096103376773;2189.321310393783;2143.431990522513;2166.306781829815;2215.6898034275214;2220.8667479951255;2231;2160.4490854831997;2161.3407910587266;2171.9782802171935;2178.16140785797;2222.03341546427;2155.3964889830872;2157.072458842697;2167.4364665187086;2168.642174041281;2168.826493880486;2112.2923820520145;2144.828413726898;2144.860584062031;2144.946376340604;2145.9034343454427;7298.1607115181905;7300.488965772398;7304.598247096407;7342;7351.963240183818;4234.87295381139;4321.638683814588;4327.0480494291205;4358.455193100863;4384.517703052662;2711.349276173724;2738.8904443822225;2891.9277018074717;2917.5331946888396;2962.0817546560634;910.7950711089952;938.7183844846519;960.7694153403203;968.9757756056155;971.956261968206;9572.377795443273;9584.04159584043;9605.279604029725;9606.327557071008;9684.95157524208;3866.9806650966566;4176.227397931392;4187.225363307798;4188.267053265728;4191.392248124005;8407;8417.200365965224;8418.663253469915;8435.536045517432;8445.451045682012;4305.6986010978935;4317.266064768997;4320.243957307459;4334.739915605074;4336.436263285753;3499.737519686034;3937.2125574885135;3938.0942383252013;3984.5019372578427;4066.67466602677;3594.137407022296;3629.9818500907327;3672.4491326301268;3698.093966978108;3760.1539653577724;1183.5739133911784;1191.92252503587;1213.50246398976;1219.810929305959;1229.4836168809122;838.471762789451;868.5092922498894;880.2913654508183;882.2016075451598;892.8749975003504;5293.470652934676;5370.0333939890415;5478.506934375925;5501.257330260443;5585.1901474286005;883.430187529053;910.2581396162107;925.3245131054368;944.1031020530523;951.4671783801093;3595.9820200899353;3686.1521849974656;3703.4815125882396;3716.4239542870896;3730.757500762496;8771.868421973675;9006.729798106067;9029.187373136449;9033.77415564616;9122.635094596142;8958.417702849294;9150.130737579919;9213.447193168431;9222.40054396462;9249.583768730423;6974;7069.257727938595;7095.82260443493;7099.609521476265;7127.78616641512;4935.703857768402;5073.720945347894;5180.844574662766;5190.039842629126;5205.505476979681;8217.096119426738;8338.04112527067;8480.74557763268;8515.063343032385;8538.103499132501;8463.069062403254;8707.08575599553;8741.519216442903;8748.343874209333;8763.342749293955;5859.531237501075;6429.485641148791;6624.867502650017;6625.238097618835;6725.327467253235;7254.347108760237;7268.672909719181;7318.3047610476915;7347.8163045924275;7363.926360736324;6443.420092191725;6446.709898054505;6578.276389597045;6658.234303055211;6698.229703583956;6512.511561632802;6542.051402546509;6568.6058836469965;6595.307492713388;6629.4696424284975;5948.078047902582;5986.580939334205;6010.2186715726675;6016.398360164124;6026.276846778414;4548;4600.585947264763;4623.468301145412;4638.327442520748;4666.976665116653;4584.312353147055;4649.721016739007;4678.485366609738;4694.906101878011;4707.435107787088 04:38:00 INFO - PROCESS | 16521 | |4;prototype.html;306.26801943355383;315.09410444970706;318.8357995632249;321.2178345728152;322.93702727968025;4810.278458231267;4822.397200349957;4935.87660308492;5037.4710655381205;5038.420581633109;4884.87787805305;4889.657723959324;4899.461059283485;4908.87727806805;4929.137400954836;3860.4209368594657;3870.4068274256174;3889.8833035008997;3905.4922860028155;3930.4890364252606;3641.599424063351;3867.941980870289;3883.6989608481194;3884.1454879926373;3918.745281556704;3840.3087444260022;3878.631530004645;3886.9222615547674;3893.9026524336837;3913.8043097845134;3851.5570709368503;3869.342211823997;3871.79974207995;3873.3221686204943;3873.4770805941403;3264.363449127421;3400.7109395701395;3402.8638854445794;3403.9277627547244;3423.623401425841;4751.408278226798;4754.690945088558;4759.571638552512;4778.402699662543;4778.590315856796;4412.823487060514;4426.933595996063;4438.378626992224;4449.777511124431;4471.262241730111;5058.620603454719;5211.7394130293715;5221.791128354861;5226.216067589854;5230.8169214077325;3697.2051009032916;3716.417090122366;3731.197792474631;3757;3757.774533527997;5406.405295417501;5441.449186981691;5443.564514838803;5474.37044739856;5499.890002199933;3789.4694742736037;3806.781829814433;3827.5215598050245;3840.6927445804267;3845.596212397658;3636.909077273089;3863.6715879150024;3871.6515513603913;3873.5932727063814;3877.302085624615;4362.389265502832;4369.563043695669;4410.095930334273;4426;4454.866354009385;5170.767315470813;5281.709505977131;5284.154535274338;5289.20661900718;5354.170103633943;1237.1340061956666;1269.3462866623697;1274.7450509898058;1303.8109474126388;1316.2628927800463;888.493558671551;903.4037535226719;903.6972614174193;909.4634165842185;910.2081189365294;4424.446944131983;4440.977795111068;4454.265046267395;4455.598996090367;4460.50934397216;5056.84829455117;5073.264376665363;5074.340335756328;5096.464871188546;5176.948230517722;4348.173846969065;4428.535003824616;4435.246008178618;4437;4468.262736648481;2670.212287375229;2852.816081326268;2857.2428306498796;2860.9713902860703;2867.813592116506;4974.452810190876;4979.576735977483;4979.726115063634;4997.650164488451;5012.097822391932;5293.497117773805;5450.073487507054;5452.345718513804;5470.343558772973;5521.337439507285;4963.726995015164;4971.806766376044;4999.975000124976;5021.49785021495;5028.84913452597;5241.6068794839775;5271.841844744664;5302.602304827076;5308.203769434615;5317.441668624739;5021.811149919754;5207.1668533034535;5220.634555581073;5301.231321458444;5304.893902121858;4948.529889660476;4961.479044700254;4966;4974.452810190804;5004.274380214922;3681;3699.2231631357718;3708.68476179517;3713.405855063177;3732.64539868712;5067.694199139309;5127;5185.533302002837;5194.558462530576;5250.842474725764;4987.152184128634;5013.197888337849;5064.417591976822;5076.137056700296;5103.693778373309;5064.82273120439;5075.1625981712605;5087.592992560661;5089.465606111305;5110.9488905110475;4730.557180060115;4944.307796908508;4981.92888528968;5015.445211984296;5055.823046193365;5104.642675012714;5113.667611605234;5113.821016264562;5115.976804639162;5121.487851214849;4997.275395067622;5033.320501732219;5033.899322013613;5039.672421292605;5044.621653376085 04:38:00 INFO - PROCESS | 16521 | |5;yui.html;702.9051078104455;807.6405999330296;818.8689809630457;832.138736407818;838.061371264184;12347.938260308709;12615.369231538409;12646.367681615928;12663.430145643446;12687.429065692042;13594.388252528635;13636.181829090237;13651.317434128303;13657.04400691952;13741.725165496684;669.0566301514865;858.4591707224471;887.3522328700037;892.4823602310644;892.78573142446;873.5151990645189;881.3037700216853;881.3918396306528;881.9867701984475;884.1688812516246;913.8674892140635;917.0874979395511;918.4626993208981;919.3334832246635;923.3490389275545;916.1159481100736;917;919.462114662923;921.5944984206994;921.9354645174841;667.7729571945562;669.10340144207;672.0725398949419;673.229152620252;673.2459645197362;12510.18683785551;12519.74960500794;12535.686607834787;12558.058145639114;12594.43325050375;12180.390980451031;12435.884015492487;12519.624411267676;12550.937245313806;12859.35703214845;9948.452835094067;9980.401175929468;10047.497625118787;10228.795424091551;10413.323133996266;3288.1615188126875;3308.715799093106;3311.4536101543217;3320.5517255170485;3416.7437442191685;47512;47888.76055619735;48442.757786210845;48504.75747621239;48898.75550622224;8754.91245087541;8874.600642971081;9022.323325750594;9145.49699766506;9270.351075424656;15235.390584376722;15265.465708700141;15274.312655930287;15338.693226135414;15347.07917524952;6215.254169499689;6307.653079080603;6328.430441260309;6354.3010268870385;6519.250286217051;3310.668933106718;3416.6754158354915;3424.4863270509127;3477.4783782432837;3525.7531972761662;2903.50640391134;3010.5785190073407;3052.2674558105896;3055.205646531918;3064.55563943227;504.44511037858064;505.40867185393176;561.9466150715675;582.2808831093596;598.9431004054608;544.7249139184765;581.2676028204409;590.5069267161882;599.7870755881686;649.341022637986;8161.5919204039565;8204.712835050745;8272.793180170544;8312.501249925024;8445.788855278544;561.093833458969;570.7431655754926;574.5633318677751;585.4262822434039;592.9140274660236;3894.3963685628773;3896.9220615588097;3917.864068015734;3934.586868378779;4042.3532234842874;52409.73795131076;53758.19362709563;54650.180247296325;54727.72636136873;55946.720266398406;48948;50131.74934125306;50840.49159508358;51177.23234151491;51302.74348628233;38340.61659383426;39689;41859.581404186174;42547.78726106411;46015.30977035347;7924.84150317002;8069.475484093515;8071.87892181606;8136.1863813618165;8632.56837158127;29036.7096329034;29301.706982929896;29324.413511730072;29350.55974160432;29528.261793455335;34631.65368346284;36758.816205919866;36886.63113368939;37520.81239593784;38547.42178867375;10150.441725704863;10410.78708058949;10607.575696972035;10777.676669699922;10816.08063314627;10792;10986.285891417032;11338.376389298668;11914.069290947473;11935.104867135173;10682.198835087554;10801.081908037904;11652.88347116518;11670.533178672758;11716.121290903046;10284.845727314247;10430.895691042992;10579.259451838298;10653;10884.782304354027;10106.898931010595;10184.388936663823;10275.948620256851;10774.407407592344;10803.837942430713;8831.337649676172;8993.685221017233;9193.496016184868;9309.162175404246;9519.048095190425;9119.498427586546;9280.257579393767;9443.95278023633;9498.857517137387;9561.856572151284 04:38:00 INFO - PROCESS | 16521 | __end_tp_report 04:38:00 INFO - PROCESS | 16521 | __start_cc_report 04:38:00 INFO - PROCESS | 16521 | _x_x_mozilla_cycle_collect,385 04:38:00 INFO - PROCESS | 16521 | __end_cc_report 04:38:00 INFO - PROCESS | 16521 | __startTimestamp1462880280402__endTimestamp 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | ------- Summary: start ------- 04:38:00 INFO - PROCESS | 16521 | Number of tests: 6 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#0] dojo.html Cycles:165 Average:4804.40 Median:4899.29 stddev:498.72 (10.2%) stddev-sans-first:470.79 04:38:00 INFO - PROCESS | 16521 | Values: 2651.9 2716.4 2735.6 2737.1 2752.6 4772.4 4794.5 4798.6 4875.1 4955.9 4751.3 4820.8 4845.6 4862.5 4902.3 4392.8 4519.7 4547.3 4581.9 4613.7 4481.0 4543.2 4545.0 4551.0 4556.8 4403.4 4425.6 4447.0 4452.2 4500.9 4459.5 4467.4 4476.9 4486.7 4507.6 4492.3 4515.5 4519.0 4532.2 4555.5 4726.1 4752.9 4787.8 4788.8 4793.8 5217.2 5228.2 5231.6 5242.9 5284.6 4974.0 5280.3 5291.4 5291.7 5305.2 4842.2 4876.8 4880.6 4888.1 4899.3 5303.0 5337.9 5348.4 5353.1 5387.4 4839.4 5069.8 5108.7 5122.8 5138.5 5193.6 5229.8 5250.0 5251.3 5302.7 5018.7 5152.2 5163.0 5213.0 5232.4 5007.0 5143.4 5204.8 5208.2 5208.2 4437.5 4491.8 4492.5 4534.4 4539.0 3871.4 3877.4 3879.1 3899.6 3923.9 4325.7 4385.5 4432.9 4450.8 4525.7 5175.7 5190.7 5212.4 5217.7 5252.6 4426.3 4434.9 4444.1 4473.0 4480.0 4607.2 4673.3 4678.3 4693.9 4709.8 4890.1 4898.7 4900.2 4908.1 4946.6 5195.3 5213.2 5214.6 5215.8 5231.6 4802.2 4809.4 4828.0 4848.5 4865.0 5087.2 5094.6 5095.5 5121.1 5163.5 5172.9 5183.8 5196.4 5232.3 5282.4 4893.5 4917.7 5131.0 5145.4 5170.8 4928.3 4984.0 5013.0 5037.4 5045.4 4947.6 4996.5 5006.7 5017.1 5062.7 4882.5 5079.7 5095.8 5112.3 5126.5 4980.7 4981.4 4998.5 5042.0 5078.0 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#1] ext.html Cycles:180 Average:48315.85 Median:207482.81 stddev:84781.57 (40.9%) stddev-sans-first:84943.67 04:38:00 INFO - PROCESS | 16521 | Values: 587.9 607.3 613.2 625.7 635.0 35579.1 39803.6 40010.6 40043.2 40048.4 40185.6 40761.8 40785.0 40908.2 40942.2 7827.2 7936.2 7938.6 7969.2 7979.4 7852.5 7964.1 7966.7 7999.4 8015.0 8000.4 8024.6 8030.3 8040.3 8052.7 7945.2 7952.2 7980.1 8004.0 8035.6 7838.3 7848.9 7906.2 7915.7 7923.3 30586.4 37610.1 37730.6 37959.8 38020.6 3189.3 3348.2 3377.3 3876.8 4120.5 27912.9 31370.2 31571.0 32640.5 34987.0 3278.6 3299.1 3329.0 3346.1 3347.8 245345.0 250281.0 250824.0 251502.0 251707.0 61970.7 62031.0 62539.0 62649.7 62754.0 36512.6 37599.6 37617.8 64273.4 64474.4 13501.6 13680.2 13721.1 13725.4 13808.4 10023.7 10149.7 10198.5 10205.3 10253.8 19767.6 19842.5 20166.4 20256.4 20279.6 7751.6 7961.7 8079.3 8087.4 8100.1 923.7 1018.2 1031.5 1035.7 1095.3 29617.9 29684.6 29969.6 30242.7 30273.2 1021.8 1022.0 1048.3 1053.8 1168.2 15581.6 15917.9 16047.6 16053.6 16355.2 374854.0 377235.0 380486.0 381023.0 382330.0 51748.0 52171.7 52331.2 52471.5 52569.0 1249.6 1261.7 1270.7 1280.3 1287.6 27905.2 29044.4 29174.9 29232.6 29869.3 43606.6 45194.5 45389.8 45470.5 45584.3 322661.0 325769.0 325972.0 326058.0 327500.0 26823.3 27073.7 27133.0 27153.6 27222.0 44321.8 45037.0 45480.8 45732.1 46090.0 38131.0 38690.4 38816.6 40011.8 40089.0 37822.0 38314.8 39854.8 40287.0 41958.0 33356.7 39082.6 39202.4 39526.6 39579.8 34520.3 35202.3 35314.8 35496.5 35804.0 26299.7 26448.7 26821.5 26950.1 27414.5 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#2] jquery.html Cycles:180 Average:24590.47 Median:4581.31 stddev:68717.16 (1499.9%) stddev-sans-first:68885.87 04:38:00 INFO - PROCESS | 16521 | Values: 376.3 378.9 380.9 387.0 395.3 16148.0 16584.9 17462.3 17465.2 17537.7 10489.9 16044.1 16910.6 16924.3 17496.7 4468.2 4582.5 4637.8 4639.2 4656.8 3497.1 5157.2 5474.0 5487.4 5545.0 5440.2 5464.2 5481.4 5532.3 5538.9 5300.6 5443.2 5455.5 5457.2 5463.0 4622.5 5302.0 5308.1 5309.2 5309.2 11045.4 11129.8 11207.7 11209.8 11223.7 1941.3 2024.6 2071.9 2092.7 2158.4 8815.4 8858.8 8965.4 8979.1 9595.2 1754.2 1791.5 1809.7 1834.5 1859.7 69782.0 72695.0 72721.6 72882.6 73053.6 9460.8 9553.8 9866.0 10127.1 10520.2 14532.3 14670.9 14686.4 14689.1 14782.9 7072.3 7099.0 7180.8 7263.6 7287.4 6319.3 6328.1 6419.5 6499.3 6642.3 4384.6 4432.9 4515.5 4580.2 4624.4 1611.3 1731.3 1756.6 1772.4 1796.4 888.4 913.2 981.9 1026.8 1065.2 16528.0 16661.7 16694.0 17091.5 17111.7 953.2 957.4 973.3 979.5 985.9 9450.2 9484.4 9502.2 9623.5 9644.4 408105.0 417767.0 418160.0 420694.0 420933.0 51129.7 74219.3 76648.0 77468.2 79798.0 917.1 935.1 944.4 962.3 967.3 14973.4 15019.3 15156.2 15209.8 15385.5 34216.8 35350.5 36257.5 36327.8 36426.8 48538.3 49028.0 49562.5 49849.0 49906.8 6646.7 7085.5 7241.3 7448.6 7557.5 9049.9 11386.8 11462.4 12046.9 12260.8 10492.4 10656.4 10662.9 10830.1 10989.0 10265.3 10449.6 10646.6 10749.7 10844.2 5643.8 7928.5 10498.3 10638.6 10684.8 7956.8 7993.5 8020.2 8195.3 8232.6 9549.9 10485.4 10504.0 10659.7 10881.7 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#3] mootools.html Cycles:180 Average:4951.13 Median:5903.80 stddev:2654.61 (45.0%) stddev-sans-first:2649.22 04:38:00 INFO - PROCESS | 16521 | Values: 1477.5 1527.9 1669.6 1797.5 1814.3 6489.5 7103.3 7134.0 7614.1 7627.2 7083.3 7326.0 7377.7 7380.9 7391.4 2144.3 2172.7 2172.7 2179.5 2189.3 2143.4 2166.3 2215.7 2220.9 2231.0 2160.4 2161.3 2172.0 2178.2 2222.0 2155.4 2157.1 2167.4 2168.6 2168.8 2112.3 2144.8 2144.9 2144.9 2145.9 7298.2 7300.5 7304.6 7342.0 7352.0 4234.9 4321.6 4327.0 4358.5 4384.5 2711.3 2738.9 2891.9 2917.5 2962.1 910.8 938.7 960.8 969.0 972.0 9572.4 9584.0 9605.3 9606.3 9685.0 3867.0 4176.2 4187.2 4188.3 4191.4 8407.0 8417.2 8418.7 8435.5 8445.5 4305.7 4317.3 4320.2 4334.7 4336.4 3499.7 3937.2 3938.1 3984.5 4066.7 3594.1 3630.0 3672.4 3698.1 3760.2 1183.6 1191.9 1213.5 1219.8 1229.5 838.5 868.5 880.3 882.2 892.9 5293.5 5370.0 5478.5 5501.3 5585.2 883.4 910.3 925.3 944.1 951.5 3596.0 3686.2 3703.5 3716.4 3730.8 8771.9 9006.7 9029.2 9033.8 9122.6 8958.4 9150.1 9213.4 9222.4 9249.6 6974.0 7069.3 7095.8 7099.6 7127.8 4935.7 5073.7 5180.8 5190.0 5205.5 8217.1 8338.0 8480.7 8515.1 8538.1 8463.1 8707.1 8741.5 8748.3 8763.3 5859.5 6429.5 6624.9 6625.2 6725.3 7254.3 7268.7 7318.3 7347.8 7363.9 6443.4 6446.7 6578.3 6658.2 6698.2 6512.5 6542.1 6568.6 6595.3 6629.5 5948.1 5986.6 6010.2 6016.4 6026.3 4548.0 4600.6 4623.5 4638.3 4667.0 4584.3 4649.7 4678.5 4694.9 4707.4 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#4] prototype.html Cycles:180 Average:4274.33 Median:4904.17 stddev:1231.49 (25.1%) stddev-sans-first:1198.39 04:38:00 INFO - PROCESS | 16521 | Values: 306.3 315.1 318.8 321.2 322.9 4810.3 4822.4 4935.9 5037.5 5038.4 4884.9 4889.7 4899.5 4908.9 4929.1 3860.4 3870.4 3889.9 3905.5 3930.5 3641.6 3867.9 3883.7 3884.1 3918.7 3840.3 3878.6 3886.9 3893.9 3913.8 3851.6 3869.3 3871.8 3873.3 3873.5 3264.4 3400.7 3402.9 3403.9 3423.6 4751.4 4754.7 4759.6 4778.4 4778.6 4412.8 4426.9 4438.4 4449.8 4471.3 5058.6 5211.7 5221.8 5226.2 5230.8 3697.2 3716.4 3731.2 3757.0 3757.8 5406.4 5441.4 5443.6 5474.4 5499.9 3789.5 3806.8 3827.5 3840.7 3845.6 3636.9 3863.7 3871.7 3873.6 3877.3 4362.4 4369.6 4410.1 4426.0 4454.9 5170.8 5281.7 5284.2 5289.2 5354.2 1237.1 1269.3 1274.7 1303.8 1316.3 888.5 903.4 903.7 909.5 910.2 4424.4 4441.0 4454.3 4455.6 4460.5 5056.8 5073.3 5074.3 5096.5 5176.9 4348.2 4428.5 4435.2 4437.0 4468.3 2670.2 2852.8 2857.2 2861.0 2867.8 4974.5 4979.6 4979.7 4997.7 5012.1 5293.5 5450.1 5452.3 5470.3 5521.3 4963.7 4971.8 5000.0 5021.5 5028.8 5241.6 5271.8 5302.6 5308.2 5317.4 5021.8 5207.2 5220.6 5301.2 5304.9 4948.5 4961.5 4966.0 4974.5 5004.3 3681.0 3699.2 3708.7 3713.4 3732.6 5067.7 5127.0 5185.5 5194.6 5250.8 4987.2 5013.2 5064.4 5076.1 5103.7 5064.8 5075.2 5087.6 5089.5 5110.9 4730.6 4944.3 4981.9 5015.4 5055.8 5104.6 5113.7 5113.8 5116.0 5121.5 4997.3 5033.3 5033.9 5039.7 5044.6 04:38:00 INFO - PROCESS | 16521 | 04:38:00 INFO - PROCESS | 16521 | [#5] yui.html Cycles:180 Average:12852.18 Median:48473.76 stddev:14866.82 (30.7%) stddev-sans-first:14880.53 04:38:00 INFO - PROCESS | 16521 | Values: 702.9 807.6 818.9 832.1 838.1 12347.9 12615.4 12646.4 12663.4 12687.4 13594.4 13636.2 13651.3 13657.0 13741.7 669.1 858.5 887.4 892.5 892.8 873.5 881.3 881.4 882.0 884.2 913.9 917.1 918.5 919.3 923.3 916.1 917.0 919.5 921.6 921.9 667.8 669.1 672.1 673.2 673.2 12510.2 12519.7 12535.7 12558.1 12594.4 12180.4 12435.9 12519.6 12550.9 12859.4 9948.5 9980.4 10047.5 10228.8 10413.3 3288.2 3308.7 3311.5 3320.6 3416.7 47512.0 47888.8 48442.8 48504.8 48898.8 8754.9 8874.6 9022.3 9145.5 9270.4 15235.4 15265.5 15274.3 15338.7 15347.1 6215.3 6307.7 6328.4 6354.3 6519.3 3310.7 3416.7 3424.5 3477.5 3525.8 2903.5 3010.6 3052.3 3055.2 3064.6 504.4 505.4 561.9 582.3 598.9 544.7 581.3 590.5 599.8 649.3 8161.6 8204.7 8272.8 8312.5 8445.8 561.1 570.7 574.6 585.4 592.9 3894.4 3896.9 3917.9 3934.6 4042.4 52409.7 53758.2 54650.2 54727.7 55946.7 48948.0 50131.7 50840.5 51177.2 51302.7 38340.6 39689.0 41859.6 42547.8 46015.3 7924.8 8069.5 8071.9 8136.2 8632.6 29036.7 29301.7 29324.4 29350.6 29528.3 34631.7 36758.8 36886.6 37520.8 38547.4 10150.4 10410.8 10607.6 10777.7 10816.1 10792.0 10986.3 11338.4 11914.1 11935.1 10682.2 10801.1 11652.9 11670.5 11716.1 10284.8 10430.9 10579.3 10653.0 10884.8 10106.9 10184.4 10275.9 10774.4 10803.8 8831.3 8993.7 9193.5 9309.2 9519.0 9119.5 9280.3 9444.0 9498.9 9561.9 04:38:00 INFO - PROCESS | 16521 | -------- Summary: end -------- 04:38:00 INFO - PROCESS | 16521 | 04:38:01 INFO - TEST-INFO | 16521: exit 0 04:38:01 INFO - TEST-OK | dromaeo_css | took 1115929ms 04:38:01 INFO - TEST-START | kraken 04:38:01 INFO - operating with platform_type : linux_ 04:38:01 INFO - Initialising browser for kraken test... 04:38:01 INFO - TEST-INFO | started process 16759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBoNLh/profile http://localhost:33292/getInfo.html) 04:38:05 INFO - PROCESS | 16759 | 04:38:05 INFO - PROCESS | 16759 | (process:16827): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:38:06 INFO - PROCESS | 16759 | __metrics Screen width/height:1600/1200 04:38:06 INFO - PROCESS | 16759 | colorDepth:24 04:38:06 INFO - PROCESS | 16759 | Browser inner width/height: 1024/697 04:38:06 INFO - PROCESS | 16759 | __metrics 04:38:06 ERROR - PROCESS | 16759 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:38:07 INFO - TEST-INFO | 16759: exit 0 04:38:07 INFO - Browser initialized. 04:38:07 INFO - Running cycle 1/1 for kraken test... 04:38:07 INFO - TEST-INFO | started process 16878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBoNLh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:09 INFO - PROCESS | 16878 | 04:38:09 INFO - PROCESS | 16878 | (process:16939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:38:19 INFO - PROCESS | 16878 | RSS: Main: 163942400 04:38:19 INFO - PROCESS | 16878 | 04:38:22 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33292/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:23 INFO - PROCESS | 16878 | RSS: Main: 166928384 04:38:23 INFO - PROCESS | 16878 | 04:38:26 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33292/tests/kraken/driver.html?testName=audio-dft) 04:38:27 INFO - PROCESS | 16878 | RSS: Main: 167534592 04:38:27 INFO - PROCESS | 16878 | 04:38:30 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33292/tests/kraken/driver.html?testName=audio-fft) 04:38:30 INFO - PROCESS | 16878 | RSS: Main: 163287040 04:38:30 INFO - PROCESS | 16878 | 04:38:32 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33292/tests/kraken/driver.html?testName=audio-oscillator) 04:38:33 INFO - PROCESS | 16878 | RSS: Main: 163758080 04:38:33 INFO - PROCESS | 16878 | 04:38:35 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:36 INFO - PROCESS | 16878 | RSS: Main: 164192256 04:38:36 INFO - PROCESS | 16878 | 04:38:39 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33292/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:40 INFO - PROCESS | 16878 | RSS: Main: 164188160 04:38:40 INFO - PROCESS | 16878 | 04:38:43 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33292/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:44 INFO - PROCESS | 16878 | RSS: Main: 162791424 04:38:44 INFO - PROCESS | 16878 | 04:38:47 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33292/tests/kraken/driver.html?testName=json-parse-financial) 04:38:48 INFO - PROCESS | 16878 | RSS: Main: 163635200 04:38:48 INFO - PROCESS | 16878 | 04:38:50 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:50 INFO - PROCESS | 16878 | RSS: Main: 164524032 04:38:50 INFO - PROCESS | 16878 | 04:38:52 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:53 INFO - PROCESS | 16878 | RSS: Main: 164663296 04:38:53 INFO - PROCESS | 16878 | 04:38:55 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:56 INFO - PROCESS | 16878 | RSS: Main: 164859904 04:38:56 INFO - PROCESS | 16878 | 04:38:59 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:59 INFO - PROCESS | 16878 | RSS: Main: 164679680 04:38:59 INFO - PROCESS | 16878 | 04:39:02 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:03 INFO - PROCESS | 16878 | RSS: Main: 164257792 04:39:03 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | Cycle 1(1): loaded http://localhost:33292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33292/tests/kraken/driver.html?testName=ai-astar) 04:39:05 INFO - PROCESS | 16878 | RSS: Main: 166445056 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | __start_tp_report 04:39:05 INFO - PROCESS | 16878 | _x_x_mozilla_page_load 04:39:05 INFO - PROCESS | 16878 | _x_x_mozilla_page_load_details 04:39:05 INFO - PROCESS | 16878 | |i|pagename|runs| 04:39:05 INFO - PROCESS | 16878 | |0;ai-astar;113;114;109;114;116;119;111;117;116;116 04:39:05 INFO - PROCESS | 16878 | |1;audio-beat-detection;156;132;160;227;139;155;156;132;200;142 04:39:05 INFO - PROCESS | 16878 | |2;audio-dft;161;166;169;162;162;161;163;179;162;166 04:39:05 INFO - PROCESS | 16878 | |3;audio-fft;78;77;77;181;77;77;76;77;159;77 04:39:05 INFO - PROCESS | 16878 | |4;audio-oscillator;95;95;174;97;96;94;132;95;94;156 04:39:05 INFO - PROCESS | 16878 | |5;imaging-gaussian-blur;117;118;118;119;117;118;119;117;117;118 04:39:05 INFO - PROCESS | 16878 | |6;imaging-darkroom;148;147;148;147;147;149;147;146;147;147 04:39:05 INFO - PROCESS | 16878 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 04:39:05 INFO - PROCESS | 16878 | |8;json-parse-financial;67;67;66;68;68;66;68;67;67;69 04:39:05 INFO - PROCESS | 16878 | |9;json-stringify-tinderbox;65;66;65;65;65;66;64;66;70;65 04:39:05 INFO - PROCESS | 16878 | |10;stanford-crypto-aes;88;89;82;82;85;90;83;83;134;88 04:39:05 INFO - PROCESS | 16878 | |11;stanford-crypto-ccm;138;135;135;131;133;133;131;136;149;139 04:39:05 INFO - PROCESS | 16878 | |12;stanford-crypto-pbkdf2;171;177;174;182;171;179;171;181;172;175 04:39:05 INFO - PROCESS | 16878 | |13;stanford-crypto-sha256-iterative;69;68;73;69;71;68;72;68;66;69 04:39:05 INFO - PROCESS | 16878 | __end_tp_report 04:39:05 INFO - PROCESS | 16878 | __start_cc_report 04:39:05 INFO - PROCESS | 16878 | _x_x_mozilla_cycle_collect,926 04:39:05 INFO - PROCESS | 16878 | __end_cc_report 04:39:05 INFO - PROCESS | 16878 | __startTimestamp1462880345384__endTimestamp 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | ------- Summary: start ------- 04:39:05 INFO - PROCESS | 16878 | Number of tests: 14 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:2.95 (2.5%) stddev-sans-first:3.08 04:39:05 INFO - PROCESS | 16878 | Values: 113.0 114.0 109.0 114.0 116.0 119.0 111.0 117.0 116.0 116.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#1] audio-beat-detection Cycles:10 Average:159.90 Median:156.00 stddev:30.69 (19.7%) stddev-sans-first:32.52 04:39:05 INFO - PROCESS | 16878 | Values: 156.0 132.0 160.0 227.0 139.0 155.0 156.0 132.0 200.0 142.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:5.55 (3.4%) stddev-sans-first:5.68 04:39:05 INFO - PROCESS | 16878 | Values: 161.0 166.0 169.0 162.0 162.0 161.0 163.0 179.0 162.0 166.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#3] audio-fft Cycles:10 Average:95.60 Median:77.00 stddev:39.56 (51.4%) stddev-sans-first:41.44 04:39:05 INFO - PROCESS | 16878 | Values: 78.0 77.0 77.0 181.0 77.0 77.0 76.0 77.0 159.0 77.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:95.00 stddev:30.13 (31.7%) stddev-sans-first:31.26 04:39:05 INFO - PROCESS | 16878 | Values: 95.0 95.0 174.0 97.0 96.0 94.0 132.0 95.0 94.0 156.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 04:39:05 INFO - PROCESS | 16878 | Values: 117.0 118.0 118.0 119.0 117.0 118.0 119.0 117.0 117.0 118.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 04:39:05 INFO - PROCESS | 16878 | Values: 148.0 147.0 148.0 147.0 147.0 149.0 147.0 146.0 147.0 147.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:39:05 INFO - PROCESS | 16878 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 04:39:05 INFO - PROCESS | 16878 | Values: 67.0 67.0 66.0 68.0 68.0 66.0 68.0 67.0 67.0 69.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 04:39:05 INFO - PROCESS | 16878 | Values: 65.0 66.0 65.0 65.0 65.0 66.0 64.0 66.0 70.0 65.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:86.50 stddev:15.61 (18.1%) stddev-sans-first:16.54 04:39:05 INFO - PROCESS | 16878 | Values: 88.0 89.0 82.0 82.0 85.0 90.0 83.0 83.0 134.0 88.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:135.50 stddev:5.29 (3.9%) stddev-sans-first:5.56 04:39:05 INFO - PROCESS | 16878 | Values: 138.0 135.0 135.0 131.0 133.0 133.0 131.0 136.0 149.0 139.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:4.24 (2.4%) stddev-sans-first:4.21 04:39:05 INFO - PROCESS | 16878 | Values: 171.0 177.0 174.0 182.0 171.0 179.0 171.0 181.0 172.0 175.0 04:39:05 INFO - PROCESS | 16878 | 04:39:05 INFO - PROCESS | 16878 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:2.24 04:39:05 INFO - PROCESS | 16878 | Values: 69.0 68.0 73.0 69.0 71.0 68.0 72.0 68.0 66.0 69.0 04:39:05 INFO - PROCESS | 16878 | -------- Summary: end -------- 04:39:05 INFO - PROCESS | 16878 | 04:39:06 INFO - TEST-INFO | 16878: exit 0 04:39:06 INFO - TEST-OK | kraken | took 65298ms 04:39:06 INFO - SUITE-END | took 1181s 04:39:06 INFO - Completed test suite (00:19:41) 04:39:06 INFO - javascript benchmark 04:39:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.907183248586, 2716.388812517184, 2735.6443662323895, 2737.069396405222, 2752.5871119332096, 4772.379590653214, 4794.544518270763, 4798.592119669828, 4875.07373599016, 4955.876103097416, 4751.311059896321, 4820.783064762085, 4845.58812500937, 4862.465128835825, 4902.289168070628, 4392.802323895425, 4519.728816271017, 4547.340635607835, 4581.862544123682, 4613.6539759518, 4481.0, 4543.204939135655, 4545.022820093679, 4551.044280701057, 4556.772161391934, 4403.383526306319, 4425.623821975136, 4446.955530444687, 4452.220861349251, 4500.932486012713, 4459.464864216282, 4467.441569803775, 4476.910461790779, 4486.663500237462, 4507.616852567536, 4492.326151077332, 4515.525869783658, 4519.028408892104, 4532.161550113239, 4555.544445555418, 4726.054789042171, 4752.904941901177, 4787.784549695272, 4788.832390866338, 4793.808247670089, 5217.191335343028, 5228.163493840967, 5231.581473482112, 5242.895142097175, 5284.603654725911, 4973.95546935144, 5280.313559237313, 5291.444398338158, 5291.656042357235, 5305.177697456862, 4842.1526232909455, 4876.829310974099, 4880.560749532524, 4888.071266459361, 4899.2896030075435, 5302.973485132627, 5337.919931201035, 5348.3849357323625, 5353.0899747043095, 5387.353517577837, 4839.395075615548, 5069.797208111708, 5108.66793658411, 5122.769475373617, 5138.511841375063, 5193.636445448782, 5229.764660590283, 5250.028744682246, 5251.264822924793, 5302.681839089667, 5018.673786203885, 5152.227165925141, 5162.97418512905, 5213.035588416155, 5232.372115346183, 5007.023630392038, 5143.3570803649545, 5204.843854684365, 5208.218767184877, 5208.244804503402, 4437.534058923831, 4491.842785502492, 4492.528284530143, 4534.410526631583, 4538.977305113453, 3871.4192871069004, 3877.4377715231135, 3879.127196380848, 3899.6490315871706, 3923.9019024524614, 4325.740455572675, 4385.473743150778, 4432.911341773147, 4450.821967121344, 4525.728456292633, 5175.7153356564995, 5190.688558686491, 5212.374515058217, 5217.739113044333, 5252.579793616502, 4426.336049592523, 4434.866953991385, 4444.1333939881415, 4473.015936493966, 4479.955200448019, 4607.193741095295, 4673.275642275453, 4678.3216433616935, 4693.906121877543, 4709.811607535728, 4890.07088653169, 4898.706077635354, 4900.240462728283, 4908.116539022939, 4946.554810067111, 5195.272661827423, 5213.244079608511, 5214.608904332114, 5215.817446389358, 5231.633785634969, 4802.207635740064, 4809.422869255712, 4827.951720482891, 4848.539388758062, 4864.975675121602, 5087.160618498055, 5094.617903657167, 5095.541401273903, 5121.103806833864, 5163.509466600667, 5172.870678233075, 5183.792648294026, 5196.4283928767045, 5232.26748255237, 5282.445343239058, 4893.535114164149, 4917.704937703749, 5131.0, 5145.4340022598235, 5170.793168273377, 4928.285398617252, 4984.028114517634, 5012.997400519984, 5037.420696619789, 5045.394552653705, 4947.554720075211, 4996.475370086088, 5006.7246301452315, 5017.071841709296, 5062.721550314768, 4882.536159064884, 5079.695218286767, 5095.847124586268, 5112.335396398445, 5126.53861152498, 4980.726060066731, 4981.37732783402, 4998.525140111684, 5042.042012017705, 5078.035173317206], "value": 4772.940785549748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9123621300595, 607.3107023528297, 613.2181468627499, 625.6871564217892, 635.0474288567151, 35579.11052223692, 39803.60196398035, 40010.59989400109, 40043.1991360173, 40048.39927401084, 40185.59814401855, 40761.79619101908, 40785.0, 40908.181836363256, 40942.18115637686, 7827.1781462946565, 7936.24605662464, 7938.6427610757655, 7969.242921922408, 7979.441439099265, 7852.528848269094, 7964.084130325029, 7966.6813327467125, 7999.36005119589, 8015.0, 8000.359971202319, 8024.558649274288, 8030.277275045245, 8040.276375126237, 8052.718154864581, 7945.165757595456, 7952.204779522031, 7980.082290536576, 8003.95998020012, 8035.638396272182, 7838.333741631911, 7848.882266766003, 7906.248906353945, 7915.722949696733, 7923.286904178652, 30586.38827223443, 37610.05974850623, 37730.62269377326, 37959.81020094882, 38020.61979380198, 3189.346184032268, 3348.1796959744775, 3377.3245350929665, 3876.8061596920043, 4120.546739858643, 27912.86043569769, 31370.21574460657, 31571.0, 32640.510392344135, 34987.0, 3278.606567211926, 3299.1257316811066, 3328.9500657490157, 3346.113279980807, 3347.7991320520846, 245345.0, 250280.99999999817, 250824.0, 251502.0, 251707.0, 61970.69014654898, 62031.0, 62539.0, 62649.68675156595, 62754.0, 36512.634873650924, 37599.62400376016, 37617.81191094027, 64273.35726642767, 64474.355256446834, 13501.59495215145, 13680.247586382844, 13721.108127971649, 13725.382357793724, 13808.378622961991, 10023.69928902134, 10149.695509134737, 10198.490075496196, 10205.285630005978, 10253.84619230712, 19767.604647906963, 19842.50393740168, 20166.39500814978, 20256.392308230777, 20279.59440811205, 7751.612419379008, 7961.681532738626, 8079.272865442138, 8087.353011759045, 8100.149484304063, 923.7459698582943, 1018.2261481274285, 1031.5203430404897, 1035.7203555040096, 1095.2606990281529, 29617.85191074074, 29684.554731679043, 29969.550456743167, 30242.697573024427, 30273.24316892095, 1021.7598864266891, 1022.0188618925766, 1048.339546085961, 1053.773438710681, 1168.1881092640704, 15581.610459738597, 15917.930669012954, 16047.598810029842, 16053.598660033593, 16355.182240887909, 374854.0, 377235.0, 380486.0, 381023.0, 382330.0, 51748.0, 52171.73914130481, 52331.215031774555, 52471.47528524742, 52569.0, 1249.6188662458037, 1261.7413430246777, 1270.7140893299118, 1280.2894393611634, 1287.587971849018, 27905.16284511468, 29044.419111617226, 29174.854125729235, 29232.559867263633, 29869.253268668457, 43606.56393436025, 45194.54805451904, 45389.773051134536, 45470.54529454663, 45584.316235255836, 322661.0, 325769.0, 325972.0, 326058.0, 327500.0, 26823.329416764736, 27073.729262707122, 27133.0, 27153.59269610997, 27222.0, 44321.778391109125, 45037.0, 45480.772596136805, 45732.08535829331, 46090.0, 38131.046723831016, 38690.41964370593, 38816.6118338813, 40011.79994100011, 40089.0, 37822.0, 38314.80842595769, 39854.80072599618, 40287.0, 41958.0, 33356.66643333633, 39082.6091739079, 39202.41196381999, 39526.60473395229, 39579.80210098931, 34520.30959380849, 35202.29595408129, 35314.82342588271, 35496.46755298621, 35804.0, 26299.73700262973, 26448.7355126454, 26821.463570728865, 26950.085215487758, 27414.45171096527], "value": 18289.985837044846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3132283582462, 378.9450529673197, 380.8647929984857, 387.0, 395.30229145558076, 16148.0, 16584.917075414636, 17462.30150793967, 17465.214065367058, 17537.736933946002, 10489.947550262257, 16044.11757353348, 16910.577235569115, 16924.323027078903, 17496.668721783593, 4468.218061839189, 4582.450105987286, 4637.814487420499, 4639.211334073216, 4656.813727450898, 3497.090756403328, 5157.174852023677, 5473.972630136844, 5487.42382049883, 5544.972275138619, 5440.173512483657, 5464.23500709901, 5481.397046324901, 5532.336119665646, 5538.9169162462595, 5300.628955973083, 5443.237946687467, 5455.454454554552, 5457.154141108134, 5463.016657001758, 4622.537746225385, 5302.045631786277, 5308.124159513675, 5309.203619457074, 5309.203619457112, 11045.39250341231, 11129.777404451866, 11207.719807004809, 11209.831852522218, 11223.66329010131, 1941.3011315926256, 2024.595080983809, 2071.85497015209, 2092.7157584976285, 2158.4493508178957, 8815.382923195379, 8858.789424745535, 8965.372423930328, 8979.057198994142, 9595.23238140954, 1754.2193723792918, 1791.4536066499713, 1809.6923523001121, 1834.5230240137528, 1859.711744679577, 69782.0, 72695.0, 72721.63639181823, 72882.63558682226, 73053.63473182653, 9460.810783784424, 9553.761155971017, 9865.950670246602, 10127.088562029452, 10520.210984176218, 14532.27338633064, 14670.926645366704, 14686.41254349814, 14689.118652880861, 14782.926085369505, 7072.292770722989, 7099.0, 7180.7845764627145, 7263.6005019724425, 7287.417006639562, 6319.33646967071, 6328.050792381087, 6419.51853610981, 6499.252585952581, 6642.335766423319, 4384.649228061748, 4432.867013989586, 4515.458145022552, 4580.175568397721, 4624.375709279204, 1611.2668735725217, 1731.2555601091399, 1756.604763928106, 1772.4328214971342, 1796.3712700554963, 888.4225253585092, 913.2237598041611, 981.8527220916919, 1026.7535791410157, 1065.248999455382, 16528.0, 16661.6667666646, 16693.99836009819, 17091.48725538236, 17111.65776684484, 953.1755031897359, 957.4207604399378, 973.3089506450358, 979.4710856137606, 985.9408435493893, 9450.196733277748, 9484.383515071499, 9502.239820814319, 9623.52637893262, 9644.373115747454, 408105.0, 417767.0, 418160.0, 420694.0, 420933.0, 51129.74435127875, 74219.25780742231, 76648.0, 77468.22531774723, 79798.0, 917.1058218237299, 935.0649350649351, 944.3719926249105, 962.3119469579284, 967.327707243459, 14973.401063957755, 15019.32413041394, 15156.24218789034, 15209.847901521285, 15385.461508847136, 34216.82891585526, 35350.46974295439, 36257.45613815848, 36327.81836090803, 36426.81786591156, 48538.27192592184, 49028.0, 49562.50437495579, 49849.0, 49906.75046624744, 6646.667666616747, 7085.468589855678, 7241.312075352833, 7448.553086814808, 7557.470977031555, 9049.909500904907, 11386.829197562209, 11462.369569673749, 12046.879531204575, 12260.816087758512, 10492.422916739653, 10656.413897235416, 10662.946685266525, 10830.133589312678, 10989.010989011027, 10265.281430299807, 10449.63426280107, 10646.627368042082, 10749.677509674722, 10844.18668599874, 5643.802466913638, 7928.524288542706, 10498.265121441425, 10638.627648032281, 10684.83972740394, 7956.84086318282, 7993.520388776692, 8020.157883422156, 8195.344372450309, 8232.62953167097, 9549.856752148584, 10485.423301718478, 10504.0, 10659.733506662396, 10881.673549793202], "value": 8057.350041509108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.5271912987844, 1527.8854085943556, 1669.6076422040826, 1797.541626885145, 1814.2561549764598, 6489.480841532678, 7103.289671032894, 7134.0, 7614.086309642844, 7627.237276272377, 7083.291670832914, 7326.010988516548, 7377.741779037735, 7380.852382952337, 7391.445641576876, 2144.313819577732, 2172.6849606807004, 2172.73927128744, 2179.5096103376773, 2189.321310393783, 2143.431990522513, 2166.306781829815, 2215.6898034275214, 2220.8667479951255, 2231.0, 2160.4490854831997, 2161.3407910587266, 2171.9782802171935, 2178.16140785797, 2222.03341546427, 2155.3964889830872, 2157.072458842697, 2167.4364665187086, 2168.642174041281, 2168.826493880486, 2112.2923820520145, 2144.828413726898, 2144.860584062031, 2144.946376340604, 2145.9034343454427, 7298.1607115181905, 7300.488965772398, 7304.598247096407, 7342.0, 7351.963240183818, 4234.87295381139, 4321.638683814588, 4327.0480494291205, 4358.455193100863, 4384.517703052662, 2711.349276173724, 2738.8904443822225, 2891.9277018074717, 2917.5331946888396, 2962.0817546560634, 910.7950711089952, 938.7183844846519, 960.7694153403203, 968.9757756056155, 971.956261968206, 9572.377795443273, 9584.04159584043, 9605.279604029725, 9606.327557071008, 9684.95157524208, 3866.9806650966566, 4176.227397931392, 4187.225363307798, 4188.267053265728, 4191.392248124005, 8407.0, 8417.200365965224, 8418.663253469915, 8435.536045517432, 8445.451045682012, 4305.6986010978935, 4317.266064768997, 4320.243957307459, 4334.739915605074, 4336.436263285753, 3499.737519686034, 3937.2125574885135, 3938.0942383252013, 3984.5019372578427, 4066.67466602677, 3594.137407022296, 3629.9818500907327, 3672.4491326301268, 3698.093966978108, 3760.1539653577724, 1183.5739133911784, 1191.92252503587, 1213.50246398976, 1219.810929305959, 1229.4836168809122, 838.471762789451, 868.5092922498894, 880.2913654508183, 882.2016075451598, 892.8749975003504, 5293.470652934676, 5370.0333939890415, 5478.506934375925, 5501.257330260443, 5585.1901474286005, 883.430187529053, 910.2581396162107, 925.3245131054368, 944.1031020530523, 951.4671783801093, 3595.9820200899353, 3686.1521849974656, 3703.4815125882396, 3716.4239542870896, 3730.757500762496, 8771.868421973675, 9006.729798106067, 9029.187373136449, 9033.77415564616, 9122.635094596142, 8958.417702849294, 9150.130737579919, 9213.447193168431, 9222.40054396462, 9249.583768730423, 6974.0, 7069.257727938595, 7095.82260443493, 7099.609521476265, 7127.78616641512, 4935.703857768402, 5073.720945347894, 5180.844574662766, 5190.039842629126, 5205.505476979681, 8217.096119426738, 8338.04112527067, 8480.74557763268, 8515.063343032385, 8538.103499132501, 8463.069062403254, 8707.08575599553, 8741.519216442903, 8748.343874209333, 8763.342749293955, 5859.531237501075, 6429.485641148791, 6624.867502650017, 6625.238097618835, 6725.327467253235, 7254.347108760237, 7268.672909719181, 7318.3047610476915, 7347.8163045924275, 7363.926360736324, 6443.420092191725, 6446.709898054505, 6578.276389597045, 6658.234303055211, 6698.229703583956, 6512.511561632802, 6542.051402546509, 6568.6058836469965, 6595.307492713388, 6629.4696424284975, 5948.078047902582, 5986.580939334205, 6010.2186715726675, 6016.398360164124, 6026.276846778414, 4548.0, 4600.585947264763, 4623.468301145412, 4638.327442520748, 4666.976665116653, 4584.312353147055, 4649.721016739007, 4678.485366609738, 4694.906101878011, 4707.435107787088], "value": 4062.7017101243537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.26801943355383, 315.09410444970706, 318.8357995632249, 321.2178345728152, 322.93702727968025, 4810.278458231267, 4822.397200349957, 4935.87660308492, 5037.4710655381205, 5038.420581633109, 4884.87787805305, 4889.657723959324, 4899.461059283485, 4908.87727806805, 4929.137400954836, 3860.4209368594657, 3870.4068274256174, 3889.8833035008997, 3905.4922860028155, 3930.4890364252606, 3641.599424063351, 3867.941980870289, 3883.6989608481194, 3884.1454879926373, 3918.745281556704, 3840.3087444260022, 3878.631530004645, 3886.9222615547674, 3893.9026524336837, 3913.8043097845134, 3851.5570709368503, 3869.342211823997, 3871.79974207995, 3873.3221686204943, 3873.4770805941403, 3264.363449127421, 3400.7109395701395, 3402.8638854445794, 3403.9277627547244, 3423.623401425841, 4751.408278226798, 4754.690945088558, 4759.571638552512, 4778.402699662543, 4778.590315856796, 4412.823487060514, 4426.933595996063, 4438.378626992224, 4449.777511124431, 4471.262241730111, 5058.620603454719, 5211.7394130293715, 5221.791128354861, 5226.216067589854, 5230.8169214077325, 3697.2051009032916, 3716.417090122366, 3731.197792474631, 3757.0, 3757.774533527997, 5406.405295417501, 5441.449186981691, 5443.564514838803, 5474.37044739856, 5499.890002199933, 3789.4694742736037, 3806.781829814433, 3827.5215598050245, 3840.6927445804267, 3845.596212397658, 3636.909077273089, 3863.6715879150024, 3871.6515513603913, 3873.5932727063814, 3877.302085624615, 4362.389265502832, 4369.563043695669, 4410.095930334273, 4426.0, 4454.866354009385, 5170.767315470813, 5281.709505977131, 5284.154535274338, 5289.20661900718, 5354.170103633943, 1237.1340061956666, 1269.3462866623697, 1274.7450509898058, 1303.8109474126388, 1316.2628927800463, 888.493558671551, 903.4037535226719, 903.6972614174193, 909.4634165842185, 910.2081189365294, 4424.446944131983, 4440.977795111068, 4454.265046267395, 4455.598996090367, 4460.50934397216, 5056.84829455117, 5073.264376665363, 5074.340335756328, 5096.464871188546, 5176.948230517722, 4348.173846969065, 4428.535003824616, 4435.246008178618, 4437.0, 4468.262736648481, 2670.212287375229, 2852.816081326268, 2857.2428306498796, 2860.9713902860703, 2867.813592116506, 4974.452810190876, 4979.576735977483, 4979.726115063634, 4997.650164488451, 5012.097822391932, 5293.497117773805, 5450.073487507054, 5452.345718513804, 5470.343558772973, 5521.337439507285, 4963.726995015164, 4971.806766376044, 4999.975000124976, 5021.49785021495, 5028.84913452597, 5241.6068794839775, 5271.841844744664, 5302.602304827076, 5308.203769434615, 5317.441668624739, 5021.811149919754, 5207.1668533034535, 5220.634555581073, 5301.231321458444, 5304.893902121858, 4948.529889660476, 4961.479044700254, 4966.0, 4974.452810190804, 5004.274380214922, 3681.0, 3699.2231631357718, 3708.68476179517, 3713.405855063177, 3732.64539868712, 5067.694199139309, 5127.0, 5185.533302002837, 5194.558462530576, 5250.842474725764, 4987.152184128634, 5013.197888337849, 5064.417591976822, 5076.137056700296, 5103.693778373309, 5064.82273120439, 5075.1625981712605, 5087.592992560661, 5089.465606111305, 5110.9488905110475, 4730.557180060115, 4944.307796908508, 4981.92888528968, 5015.445211984296, 5055.823046193365, 5104.642675012714, 5113.667611605234, 5113.821016264562, 5115.976804639162, 5121.487851214849, 4997.275395067622, 5033.320501732219, 5033.899322013613, 5039.672421292605, 5044.621653376085], "value": 3886.7003271122726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.9051078104455, 807.6405999330296, 818.8689809630457, 832.138736407818, 838.061371264184, 12347.938260308709, 12615.369231538409, 12646.367681615928, 12663.430145643446, 12687.429065692042, 13594.388252528635, 13636.181829090237, 13651.317434128303, 13657.04400691952, 13741.725165496684, 669.0566301514865, 858.4591707224471, 887.3522328700037, 892.4823602310644, 892.78573142446, 873.5151990645189, 881.3037700216853, 881.3918396306528, 881.9867701984475, 884.1688812516246, 913.8674892140635, 917.0874979395511, 918.4626993208981, 919.3334832246635, 923.3490389275545, 916.1159481100736, 917.0, 919.462114662923, 921.5944984206994, 921.9354645174841, 667.7729571945562, 669.10340144207, 672.0725398949419, 673.229152620252, 673.2459645197362, 12510.18683785551, 12519.74960500794, 12535.686607834787, 12558.058145639114, 12594.43325050375, 12180.390980451031, 12435.884015492487, 12519.624411267676, 12550.937245313806, 12859.35703214845, 9948.452835094067, 9980.401175929468, 10047.497625118787, 10228.795424091551, 10413.323133996266, 3288.1615188126875, 3308.715799093106, 3311.4536101543217, 3320.5517255170485, 3416.7437442191685, 47512.0, 47888.76055619735, 48442.757786210845, 48504.75747621239, 48898.75550622224, 8754.91245087541, 8874.600642971081, 9022.323325750594, 9145.49699766506, 9270.351075424656, 15235.390584376722, 15265.465708700141, 15274.312655930287, 15338.693226135414, 15347.07917524952, 6215.254169499689, 6307.653079080603, 6328.430441260309, 6354.3010268870385, 6519.250286217051, 3310.668933106718, 3416.6754158354915, 3424.4863270509127, 3477.4783782432837, 3525.7531972761662, 2903.50640391134, 3010.5785190073407, 3052.2674558105896, 3055.205646531918, 3064.55563943227, 504.44511037858064, 505.40867185393176, 561.9466150715675, 582.2808831093596, 598.9431004054608, 544.7249139184765, 581.2676028204409, 590.5069267161882, 599.7870755881686, 649.341022637986, 8161.5919204039565, 8204.712835050745, 8272.793180170544, 8312.501249925024, 8445.788855278544, 561.093833458969, 570.7431655754926, 574.5633318677751, 585.4262822434039, 592.9140274660236, 3894.3963685628773, 3896.9220615588097, 3917.864068015734, 3934.586868378779, 4042.3532234842874, 52409.73795131076, 53758.19362709563, 54650.180247296325, 54727.72636136873, 55946.720266398406, 48948.0, 50131.74934125306, 50840.49159508358, 51177.23234151491, 51302.74348628233, 38340.61659383426, 39689.0, 41859.581404186174, 42547.78726106411, 46015.30977035347, 7924.84150317002, 8069.475484093515, 8071.87892181606, 8136.1863813618165, 8632.56837158127, 29036.7096329034, 29301.706982929896, 29324.413511730072, 29350.55974160432, 29528.261793455335, 34631.65368346284, 36758.816205919866, 36886.63113368939, 37520.81239593784, 38547.42178867375, 10150.441725704863, 10410.78708058949, 10607.575696972035, 10777.676669699922, 10816.08063314627, 10792.0, 10986.285891417032, 11338.376389298668, 11914.069290947473, 11935.104867135173, 10682.198835087554, 10801.081908037904, 11652.88347116518, 11670.533178672758, 11716.121290903046, 10284.845727314247, 10430.895691042992, 10579.259451838298, 10653.0, 10884.782304354027, 10106.898931010595, 10184.388936663823, 10275.948620256851, 10774.407407592344, 10803.837942430713, 8831.337649676172, 8993.685221017233, 9193.496016184868, 9309.162175404246, 9519.048095190425, 9119.498427586546, 9280.257579393767, 9443.95278023633, 9498.857517137387, 9561.856572151284], "value": 6006.535146788995, "unit": "score"}], "name": "dromaeo_css", "value": 6368.595677088772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 109.0, 114.0, 116.0, 119.0, 111.0, 117.0, 116.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 160.0, 227.0, 139.0, 155.0, 156.0, 132.0, 200.0, 142.0], "value": 159.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 169.0, 162.0, 162.0, 161.0, 163.0, 179.0, 162.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 181.0, 77.0, 77.0, 76.0, 77.0, 159.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 174.0, 97.0, 96.0, 94.0, 132.0, 95.0, 94.0, 156.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 117.0, 118.0, 119.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 68.0, 68.0, 66.0, 68.0, 67.0, 67.0, 69.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 66.0, 70.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 82.0, 82.0, 85.0, 90.0, 83.0, 83.0, 134.0, 88.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 135.0, 131.0, 133.0, 133.0, 131.0, 136.0, 149.0, 139.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 177.0, 174.0, 182.0, 171.0, 179.0, 171.0, 181.0, 172.0, 175.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 69.0, 71.0, 68.0, 72.0, 68.0, 66.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1612.2, "alertThreshold": 2.0}]} 04:39:06 INFO - Return code: 0 04:39:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:39:06 ERROR - # TBPL SUCCESS # 04:39:06 INFO - Running post-action listener: _resource_record_post_action 04:39:06 INFO - ##### 04:39:06 INFO - ##### Finished run-tests step (success) 04:39:06 INFO - ##### 04:39:06 INFO - Running post-run listener: _resource_record_post_run 04:39:07 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 12288; Write bytes: 535388160; Read time: 208; Write time: 512272 04:39:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246243328; Read time: 52; Write time: 250740 04:39:07 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 8192; Write bytes: 288972800; Read time: 156; Write time: 261516 04:39:07 INFO - Running post-run listener: _upload_blobber_files 04:39:07 INFO - Blob upload gear active. 04:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:07 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:39:07 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:39:07 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:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:08 INFO - (blobuploader) - INFO - Done attempting. 04:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:09 INFO - (blobuploader) - INFO - Done attempting. 04:39:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:09 INFO - Return code: 0 04:39:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3882f39dc55dd6f5d49703bf6cbfcb662d76e4b3069a6a71dfcb7e64477cd53cc74d321cd7c39020b1a567ef209e367c2c5d90ab484eb77a8c5ac2d7f91fca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc48fad1178b55eb2329ebeaf8daea89d18ce023936eb0877424c56177b3e2ebaaf3cd0b540c3328f09aa5630181c7911222168940a8e4cd9d4ab76b4dbe8d21"} 04:39:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:09 INFO - Contents: 04:39:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3882f39dc55dd6f5d49703bf6cbfcb662d76e4b3069a6a71dfcb7e64477cd53cc74d321cd7c39020b1a567ef209e367c2c5d90ab484eb77a8c5ac2d7f91fca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc48fad1178b55eb2329ebeaf8daea89d18ce023936eb0877424c56177b3e2ebaaf3cd0b540c3328f09aa5630181c7911222168940a8e4cd9d4ab76b4dbe8d21"} 04:39:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:09 INFO - Copying logs to upload dir... 04:39:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.204512 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-10 04:39:08.767025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 04:39:08.771037) ========= 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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3882f39dc55dd6f5d49703bf6cbfcb662d76e4b3069a6a71dfcb7e64477cd53cc74d321cd7c39020b1a567ef209e367c2c5d90ab484eb77a8c5ac2d7f91fca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc48fad1178b55eb2329ebeaf8daea89d18ce023936eb0877424c56177b3e2ebaaf3cd0b540c3328f09aa5630181c7911222168940a8e4cd9d4ab76b4dbe8d21"} 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.011433 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3882f39dc55dd6f5d49703bf6cbfcb662d76e4b3069a6a71dfcb7e64477cd53cc74d321cd7c39020b1a567ef209e367c2c5d90ab484eb77a8c5ac2d7f91fca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc48fad1178b55eb2329ebeaf8daea89d18ce023936eb0877424c56177b3e2ebaaf3cd0b540c3328f09aa5630181c7911222168940a8e4cd9d4ab76b4dbe8d21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 04:39:08.800372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:39:08.800748) ========= 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=574dc5aafe09851ec43d388c000001b6-1462879109.786790-152989820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:39:08.887509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 04:39:08.887852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 04:39:08.888191) ========= ========= Total master_lag: 0.17 =========