builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1456879954.75 results: success (0) buildid: 20160301152332 builduid: f0910e7f00554e75a924c768a5fef94f revision: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.753040) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.753539) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.753872) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.784832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.785169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.812092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.812454) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.862468) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.862812) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.863224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.863555) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 16:52:35-- 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% 37.3M=0s 2016-03-01 16:52:35 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.965221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:34.965537) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.016164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.016570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb25b90a05c194bfd4f498ff3ffee7440f85f1cd --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 eb25b90a05c194bfd4f498ff3ffee7440f85f1cd --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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 16:52:35,429 truncating revision to first 12 chars 2016-03-01 16:52:35,429 Setting DEBUG logging. 2016-03-01 16:52:35,429 attempt 1/10 2016-03-01 16:52:35,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb25b90a05c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 16:52:35,704 unpacking tar archive at: mozilla-central-eb25b90a05c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546978 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.576726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.577074) ========= echo eb25b90a05c194bfd4f498ff3ffee7440f85f1cd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eb25b90a05c194bfd4f498ff3ffee7440f85f1cd'] 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False eb25b90a05c194bfd4f498ff3ffee7440f85f1cd program finished with exit code 0 elapsedTime=0.004727 script_repo_revision: 'eb25b90a05c194bfd4f498ff3ffee7440f85f1cd' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.661503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.661867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 16:52:35.672185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 16:52:35.672505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:36 INFO - MultiFileLogger online at 20160301 16:52:36 in /builds/slave/test 16:52:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:52:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:36 INFO - {'append_to_log': False, 16:52:36 INFO - 'base_work_dir': '/builds/slave/test', 16:52:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:36 INFO - 'branch': 'Firefox-Non-PGO', 16:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:36 INFO - 'config_files': ('talos/linux_config.py',), 16:52:36 INFO - 'default_actions': ('clobber', 16:52:36 INFO - 'read-buildbot-config', 16:52:36 INFO - 'download-and-extract', 16:52:36 INFO - 'populate-webroot', 16:52:36 INFO - 'create-virtualenv', 16:52:36 INFO - 'install', 16:52:36 INFO - 'run-tests'), 16:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:36 INFO - 'download_minidump_stackwalk': True, 16:52:36 INFO - 'download_symbols': 'ondemand', 16:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:36 INFO - 'installer_path': 'installer.exe', 16:52:36 INFO - 'log_level': 'info', 16:52:36 INFO - 'log_name': 'talos', 16:52:36 INFO - 'log_to_console': True, 16:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:36 INFO - 'opt_config_files': (), 16:52:36 INFO - 'pip_index': False, 16:52:36 INFO - 'sps_profile': False, 16:52:36 INFO - 'sps_profile_interval': 0, 16:52:36 INFO - 'suite': 'dromaeojs', 16:52:36 INFO - 'system_bits': '32', 16:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:36 INFO - 'title': 'talos-linux64-ix-042', 16:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:36 INFO - 'use_talos_json': True, 16:52:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:36 INFO - 'work_dir': 'build'} 16:52:36 INFO - ##### 16:52:36 INFO - ##### Running clobber step. 16:52:36 INFO - ##### 16:52:36 INFO - Running pre-action listener: _resource_record_pre_action 16:52:36 INFO - Running main action method: clobber 16:52:36 INFO - rmtree: /builds/slave/test/build 16:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:37 INFO - Running post-action listener: _resource_record_post_action 16:52:37 INFO - ##### 16:52:37 INFO - ##### Running read-buildbot-config step. 16:52:37 INFO - ##### 16:52:37 INFO - Running pre-action listener: _resource_record_pre_action 16:52:37 INFO - Running main action method: read_buildbot_config 16:52:37 INFO - Using buildbot properties: 16:52:37 INFO - { 16:52:37 INFO - "project": "", 16:52:37 INFO - "product": "firefox", 16:52:37 INFO - "script_repo_revision": "production", 16:52:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:52:37 INFO - "repository": "", 16:52:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:52:37 INFO - "buildid": "20160301152332", 16:52:37 INFO - "pgo_build": "False", 16:52:37 INFO - "basedir": "/builds/slave/test", 16:52:37 INFO - "buildnumber": 8, 16:52:37 INFO - "slavename": "talos-linux64-ix-042", 16:52:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:52:37 INFO - "platform": "ubuntu64_hw", 16:52:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:52:37 INFO - "branch": "mozilla-central", 16:52:37 INFO - "repo_path": "mozilla-central", 16:52:37 INFO - "revision": "eb25b90a05c194bfd4f498ff3ffee7440f85f1cd", 16:52:37 INFO - "stage_platform": "linux64", 16:52:37 INFO - "builduid": "f0910e7f00554e75a924c768a5fef94f", 16:52:37 INFO - "slavebuilddir": "test" 16:52:37 INFO - } 16:52:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:52:37 INFO - Running post-action listener: _resource_record_post_action 16:52:37 INFO - ##### 16:52:37 INFO - ##### Running download-and-extract step. 16:52:37 INFO - ##### 16:52:37 INFO - Running pre-action listener: _resource_record_pre_action 16:52:37 INFO - Running main action method: download_and_extract 16:52:37 INFO - mkdir: /builds/slave/test/build/tests 16:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:37 INFO - https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:52:37 INFO - Downloaded 1448 bytes. 16:52:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:52:37 INFO - Using the following test package requirements: 16:52:37 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:52:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'jsshell-linux-x86_64.zip'], 16:52:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:52:37 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:52:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:37 INFO - https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:38 INFO - Downloaded 22077718 bytes. 16:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:40 INFO - Return code: 0 16:52:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:52: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')]} 16:52:40 INFO - https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:41 INFO - Downloaded 22077718 bytes. 16:52:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:42 INFO - Return code: 0 16:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:42 INFO - https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:52:43 INFO - Downloaded 10808456 bytes. 16:52:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:52:43 INFO - Return code: 0 16:52:43 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')]} 16:52:43 INFO - https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:52:45 INFO - Downloaded 54385434 bytes. 16:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:45 INFO - mkdir: /builds/slave/test/properties 16:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:45 INFO - Contents: 16:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:46 INFO - Running post-action listener: _resource_record_post_action 16:52:46 INFO - Running post-action listener: set_extra_try_arguments 16:52:46 INFO - ##### 16:52:46 INFO - ##### Running populate-webroot step. 16:52:46 INFO - ##### 16:52:46 INFO - Running pre-action listener: _resource_record_pre_action 16:52:46 INFO - Running main action method: populate_webroot 16:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:46 INFO - '--tppagecycles', 16:52:46 INFO - '7'], 16:52:46 INFO - 'tests': ['tsvgm']}}, 16:52:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:52:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:52:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'tests': ['damp', 'tps']}, 16:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['damp', 'tps']}, 16:52:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:46 INFO - 'other': {'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'other_l64': {'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'other_nol64': {'tests': ['a11yr', 16:52:46 INFO - 'ts_paint', 16:52:46 INFO - 'tpaint', 16:52:46 INFO - 'sessionrestore', 16:52:46 INFO - 'sessionrestore_no_auto_restore']}, 16:52:46 INFO - 'svgr': {'tests': ['tsvgx', 16:52:46 INFO - 'tsvgr_opacity', 16:52:46 INFO - 'tart', 16:52:46 INFO - 'tscrollx', 16:52:46 INFO - 'cart']}, 16:52:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['tsvgx', 16:52:46 INFO - 'tsvgr_opacity', 16:52:46 INFO - 'tart', 16:52:46 INFO - 'tscrollx', 16:52:46 INFO - 'cart']}, 16:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'tests': ['tp5o']}, 16:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'talos_options': ['--e10s'], 16:52:46 INFO - 'tests': ['tp5o']}, 16:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'talos_options': ['--xperf_path', 16:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:46 INFO - 'tests': ['tp5n']}, 16:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:46 INFO - 'talos_options': ['--e10s', 16:52:46 INFO - '--xperf_path', 16:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:46 INFO - 'tests': ['tp5n']}}, 16:52:46 INFO - 'talos.zip': {'path': '', 16:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:46 INFO - Running post-action listener: _resource_record_post_action 16:52:46 INFO - ##### 16:52:46 INFO - ##### Running create-virtualenv step. 16:52:46 INFO - ##### 16:52:46 INFO - Running pre-action listener: _resource_record_pre_action 16:52:46 INFO - Running main action method: create_virtualenv 16:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:46 INFO - Using real prefix '/usr' 16:52:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:48 INFO - Installing pip.................done. 16:52:48 INFO - Return code: 0 16:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:52:48 INFO - Using env: {'DISPLAY': ':0', 16:52:48 INFO - 'HOME': '/home/cltbld', 16:52:48 INFO - 'LANG': 'en_US.UTF-8', 16:52:48 INFO - 'LANGUAGE': 'en_US:en', 16:52:48 INFO - 'LOGNAME': 'cltbld', 16:52:48 INFO - 'MAIL': '/var/mail/cltbld', 16:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:48 INFO - 'MOZ_NO_REMOTE': '1', 16:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:48 INFO - 'NO_EM_RESTART': '1', 16:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:48 INFO - 'PWD': '/builds/slave/test', 16:52:48 INFO - 'SHELL': '/bin/bash', 16:52:48 INFO - 'SHLVL': '1', 16:52:48 INFO - 'TERM': 'linux', 16:52:48 INFO - 'TMOUT': '86400', 16:52:48 INFO - 'USER': 'cltbld', 16:52:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:48 INFO - '_': '/tools/buildbot/bin/python'} 16:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:52:48 INFO - Cleaning up... 16:52:48 INFO - Return code: 0 16:52:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:52:48 INFO - Using env: {'DISPLAY': ':0', 16:52:48 INFO - 'HOME': '/home/cltbld', 16:52:48 INFO - 'LANG': 'en_US.UTF-8', 16:52:48 INFO - 'LANGUAGE': 'en_US:en', 16:52:48 INFO - 'LOGNAME': 'cltbld', 16:52:48 INFO - 'MAIL': '/var/mail/cltbld', 16:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:48 INFO - 'MOZ_NO_REMOTE': '1', 16:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:48 INFO - 'NO_EM_RESTART': '1', 16:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:48 INFO - 'PWD': '/builds/slave/test', 16:52:48 INFO - 'SHELL': '/bin/bash', 16:52:48 INFO - 'SHLVL': '1', 16:52:48 INFO - 'TERM': 'linux', 16:52:48 INFO - 'TMOUT': '86400', 16:52:48 INFO - 'USER': 'cltbld', 16:52:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:48 INFO - '_': '/tools/buildbot/bin/python'} 16:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:49 INFO - Downloading/unpacking psutil>=0.7.1 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:51 INFO - Installing collected packages: psutil 16:52:51 INFO - Running setup.py install for psutil 16:52:51 INFO - building 'psutil._psutil_linux' extension 16:52:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:52:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:52:51 INFO - building 'psutil._psutil_posix' extension 16:52:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:52:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:51 INFO - Successfully installed psutil 16:52:51 INFO - Cleaning up... 16:52:51 INFO - Return code: 0 16:52:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:52:51 INFO - Using env: {'DISPLAY': ':0', 16:52:51 INFO - 'HOME': '/home/cltbld', 16:52:51 INFO - 'LANG': 'en_US.UTF-8', 16:52:51 INFO - 'LANGUAGE': 'en_US:en', 16:52:51 INFO - 'LOGNAME': 'cltbld', 16:52:51 INFO - 'MAIL': '/var/mail/cltbld', 16:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:51 INFO - 'MOZ_NO_REMOTE': '1', 16:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:51 INFO - 'NO_EM_RESTART': '1', 16:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:51 INFO - 'PWD': '/builds/slave/test', 16:52:51 INFO - 'SHELL': '/bin/bash', 16:52:51 INFO - 'SHLVL': '1', 16:52:51 INFO - 'TERM': 'linux', 16:52:51 INFO - 'TMOUT': '86400', 16:52:51 INFO - 'USER': 'cltbld', 16:52:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:51 INFO - '_': '/tools/buildbot/bin/python'} 16:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:52:53 INFO - Installing collected packages: mozsystemmonitor 16:52:53 INFO - Running setup.py install for mozsystemmonitor 16:52:53 INFO - Successfully installed mozsystemmonitor 16:52:53 INFO - Cleaning up... 16:52:53 INFO - Return code: 0 16:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:52:53 INFO - Using env: {'DISPLAY': ':0', 16:52:53 INFO - 'HOME': '/home/cltbld', 16:52:53 INFO - 'LANG': 'en_US.UTF-8', 16:52:53 INFO - 'LANGUAGE': 'en_US:en', 16:52:53 INFO - 'LOGNAME': 'cltbld', 16:52:53 INFO - 'MAIL': '/var/mail/cltbld', 16:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:53 INFO - 'MOZ_NO_REMOTE': '1', 16:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:53 INFO - 'NO_EM_RESTART': '1', 16:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:53 INFO - 'PWD': '/builds/slave/test', 16:52:53 INFO - 'SHELL': '/bin/bash', 16:52:53 INFO - 'SHLVL': '1', 16:52:53 INFO - 'TERM': 'linux', 16:52:53 INFO - 'TMOUT': '86400', 16:52:53 INFO - 'USER': 'cltbld', 16:52:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:53 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52:55 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 16:52:55 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 16:52:55 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 16:52:55 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 16:52:55 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 16:52:55 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 16:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:56 INFO - Downloading docopt-0.6.1.tar.gz 16:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:56 INFO - Running setup.py install for blobuploader 16:52:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:56 INFO - Running setup.py install for requests 16:52:57 INFO - Running setup.py install for docopt 16:52:57 INFO - Successfully installed blobuploader requests docopt 16:52:57 INFO - Cleaning up... 16:52:57 INFO - Return code: 0 16:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:52:57 INFO - Using env: {'DISPLAY': ':0', 16:52:57 INFO - 'HOME': '/home/cltbld', 16:52:57 INFO - 'LANG': 'en_US.UTF-8', 16:52:57 INFO - 'LANGUAGE': 'en_US:en', 16:52:57 INFO - 'LOGNAME': 'cltbld', 16:52:57 INFO - 'MAIL': '/var/mail/cltbld', 16:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:57 INFO - 'MOZ_NO_REMOTE': '1', 16:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:57 INFO - 'NO_EM_RESTART': '1', 16:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:57 INFO - 'PWD': '/builds/slave/test', 16:52:57 INFO - 'SHELL': '/bin/bash', 16:52:57 INFO - 'SHLVL': '1', 16:52:57 INFO - 'TERM': 'linux', 16:52:57 INFO - 'TMOUT': '86400', 16:52:57 INFO - 'USER': 'cltbld', 16:52:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:57 INFO - '_': '/tools/buildbot/bin/python'} 16:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:57 INFO - Running setup.py (path:/tmp/pip-SSIDuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:57 INFO - Running setup.py (path:/tmp/pip-MCDqyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:57 INFO - Running setup.py (path:/tmp/pip-BLdTFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:57 INFO - Running setup.py (path:/tmp/pip-aCzG5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:57 INFO - Running setup.py (path:/tmp/pip-o5gHlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:57 INFO - Running setup.py (path:/tmp/pip-rcM5RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:57 INFO - Running setup.py (path:/tmp/pip-TG1nkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:57 INFO - Running setup.py (path:/tmp/pip-IAH3tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:57 INFO - Running setup.py (path:/tmp/pip-YIKNQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:58 INFO - Running setup.py (path:/tmp/pip-AISS8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:58 INFO - Running setup.py (path:/tmp/pip-03YMDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:58 INFO - Running setup.py (path:/tmp/pip-x4_8Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:58 INFO - Running setup.py (path:/tmp/pip-wM6N9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:58 INFO - Running setup.py (path:/tmp/pip-Ro_m5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:58 INFO - Running setup.py (path:/tmp/pip-61hvRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:58 INFO - Running setup.py (path:/tmp/pip-oFEQ0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:58 INFO - Running setup.py (path:/tmp/pip-dIqWLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:58 INFO - Running setup.py install for manifestparser 16:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:52:58 INFO - Running setup.py install for mozcrash 16:52:58 INFO - Running setup.py install for mozdebug 16:52:58 INFO - Running setup.py install for mozdevice 16:52:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozfile 16:52:59 INFO - Running setup.py install for mozhttpd 16:52:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozinfo 16:52:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozInstall 16:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozleak 16:52:59 INFO - Running setup.py install for mozlog 16:52:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for moznetwork 16:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozprocess 16:52:59 INFO - Running setup.py install for mozprofile 16:52:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:52:59 INFO - Running setup.py install for mozrunner 16:53:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:00 INFO - Running setup.py install for mozscreenshot 16:53:00 INFO - Running setup.py install for moztest 16:53:00 INFO - Running setup.py install for mozversion 16:53:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:00 INFO - Running setup.py (path:/tmp/pip-pf81r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:00 INFO - Running setup.py (path:/tmp/pip-dtO8ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:00 INFO - Running setup.py (path:/tmp/pip-SjRdMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:00 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)) 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:00 INFO - Running setup.py (path:/tmp/pip-CLp1vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:00 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)) 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:00 INFO - Running setup.py (path:/tmp/pip-xXmC3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:00 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)) 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:00 INFO - Running setup.py (path:/tmp/pip-e8d0ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:01 INFO - Running setup.py (path:/tmp/pip-8fvaK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:01 INFO - Running setup.py (path:/tmp/pip-ZL5o6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:01 INFO - Running setup.py (path:/tmp/pip-PIMQJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:01 INFO - Running setup.py (path:/tmp/pip-sBrqM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:01 INFO - Running setup.py (path:/tmp/pip-0C58_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:01 INFO - Running setup.py (path:/tmp/pip-vrwzu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:01 INFO - Running setup.py (path:/tmp/pip-bdw4IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:01 INFO - Running setup.py (path:/tmp/pip-YyoZGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:01 INFO - Running setup.py (path:/tmp/pip-WEbc0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:01 INFO - Running setup.py (path:/tmp/pip-iejRPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:01 INFO - Running setup.py (path:/tmp/pip-M0rUdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:01 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)) 16:53:01 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:53:01 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:53:01 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)) 16:53:01 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)) 16:53:01 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)) 16:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:01 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 16:53:01 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 16:53:01 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 16:53:01 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 16:53:01 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 16:53:01 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 16:53:03 INFO - Downloading blessings-1.6.tar.gz 16:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:03 INFO - Installing collected packages: blessings 16:53:03 INFO - Running setup.py install for blessings 16:53:03 INFO - Successfully installed blessings 16:53:03 INFO - Cleaning up... 16:53:03 INFO - Return code: 0 16:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:04 INFO - Reading from file tmpfile_stdout 16:53:04 INFO - Current package versions: 16:53:04 INFO - argparse == 1.2.1 16:53:04 INFO - blessings == 1.6 16:53:04 INFO - blobuploader == 1.2.4 16:53:04 INFO - docopt == 0.6.1 16:53:04 INFO - manifestparser == 1.1 16:53:04 INFO - mozInstall == 1.12 16:53:04 INFO - mozcrash == 0.16 16:53:04 INFO - mozdebug == 0.1 16:53:04 INFO - mozdevice == 0.48 16:53:04 INFO - mozfile == 1.2 16:53:04 INFO - mozhttpd == 0.7 16:53:04 INFO - mozinfo == 0.9 16:53:04 INFO - mozleak == 0.1 16:53:04 INFO - mozlog == 3.1 16:53:04 INFO - moznetwork == 0.27 16:53:04 INFO - mozprocess == 0.22 16:53:04 INFO - mozprofile == 0.28 16:53:04 INFO - mozrunner == 6.11 16:53:04 INFO - mozscreenshot == 0.1 16:53:04 INFO - mozsystemmonitor == 0.0 16:53:04 INFO - moztest == 0.7 16:53:04 INFO - mozversion == 1.4 16:53:04 INFO - psutil == 3.1.1 16:53:04 INFO - requests == 1.2.3 16:53:04 INFO - wsgiref == 0.1.2 16:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:53:04 INFO - Using env: {'DISPLAY': ':0', 16:53:04 INFO - 'HOME': '/home/cltbld', 16:53:04 INFO - 'LANG': 'en_US.UTF-8', 16:53:04 INFO - 'LANGUAGE': 'en_US:en', 16:53:04 INFO - 'LOGNAME': 'cltbld', 16:53:04 INFO - 'MAIL': '/var/mail/cltbld', 16:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:04 INFO - 'MOZ_NO_REMOTE': '1', 16:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:04 INFO - 'NO_EM_RESTART': '1', 16:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:04 INFO - 'PWD': '/builds/slave/test', 16:53:04 INFO - 'SHELL': '/bin/bash', 16:53:04 INFO - 'SHLVL': '1', 16:53:04 INFO - 'TERM': 'linux', 16:53:04 INFO - 'TMOUT': '86400', 16:53:04 INFO - 'USER': 'cltbld', 16:53:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:04 INFO - '_': '/tools/buildbot/bin/python'} 16:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:53:04 INFO - Cleaning up... 16:53:04 INFO - Return code: 0 16:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:53:04 INFO - Using env: {'DISPLAY': ':0', 16:53:04 INFO - 'HOME': '/home/cltbld', 16:53:04 INFO - 'LANG': 'en_US.UTF-8', 16:53:04 INFO - 'LANGUAGE': 'en_US:en', 16:53:04 INFO - 'LOGNAME': 'cltbld', 16:53:04 INFO - 'MAIL': '/var/mail/cltbld', 16:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:04 INFO - 'MOZ_NO_REMOTE': '1', 16:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:04 INFO - 'NO_EM_RESTART': '1', 16:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:04 INFO - 'PWD': '/builds/slave/test', 16:53:04 INFO - 'SHELL': '/bin/bash', 16:53:04 INFO - 'SHLVL': '1', 16:53:04 INFO - 'TERM': 'linux', 16:53:04 INFO - 'TMOUT': '86400', 16:53:04 INFO - 'USER': 'cltbld', 16:53:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:04 INFO - '_': '/tools/buildbot/bin/python'} 16:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:04 INFO - Downloading/unpacking jsonschema 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:06 INFO - warning: no files found matching '*.txt' 16:53:06 INFO - no previously-included directories found matching 'build' 16:53:06 INFO - no previously-included directories found matching 'dist' 16:53:06 INFO - no previously-included directories found matching '.git*' 16:53:06 INFO - Installing collected packages: jsonschema, functools32 16:53:06 INFO - Running setup.py install for functools32 16:53:06 INFO - warning: no files found matching '*.txt' 16:53:06 INFO - no previously-included directories found matching 'build' 16:53:06 INFO - no previously-included directories found matching 'dist' 16:53:06 INFO - no previously-included directories found matching '.git*' 16:53:06 INFO - Successfully installed jsonschema functools32 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53:06 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')]} 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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')]} 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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 0x7f34c2053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, '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': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:07 INFO - Downloading/unpacking flake8 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:09 INFO - no previously-included directories found matching 'docs/_build' 16:53:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:09 INFO - Running setup.py install for pep8 16:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:09 INFO - no previously-included directories found matching 'docs/_build' 16:53:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:09 INFO - Cleaning up... 16:53:09 INFO - Return code: 0 16:53:09 INFO - Running post-action listener: _resource_record_post_action 16:53:09 INFO - Running post-action listener: _start_resource_monitoring 16:53:09 INFO - Starting resource monitoring. 16:53:09 INFO - ##### 16:53:09 INFO - ##### Running install step. 16:53:09 INFO - ##### 16:53:09 INFO - Running pre-action listener: _resource_record_pre_action 16:53:09 INFO - Running main action method: install 16:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:10 INFO - Reading from file tmpfile_stdout 16:53:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:10 INFO - Reading from file tmpfile_stdout 16:53:10 INFO - Output received: 16:53:10 INFO - Usage: mozinstall [options] installer 16:53:10 INFO - Options: 16:53:10 INFO - -h, --help show this help message and exit 16:53:10 INFO - -d DEST, --destination=DEST 16:53:10 INFO - Directory to install application into. [default: 16:53:10 INFO - "/builds/slave/test"] 16:53:10 INFO - --app=APP Application being installed. [default: firefox] 16:53:10 INFO - mkdir: /builds/slave/test/build/application 16:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:53:26 INFO - Reading from file tmpfile_stdout 16:53:26 INFO - Output received: 16:53:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:26 INFO - Running post-action listener: _resource_record_post_action 16:53:26 INFO - ##### 16:53:26 INFO - ##### Running run-tests step. 16:53:26 INFO - ##### 16:53:26 INFO - Running pre-action listener: _resource_record_pre_action 16:53:26 INFO - Running main action method: run_tests 16:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:26 INFO - Python 2.7.3 16:53:26 INFO - Return code: 0 16:53:26 INFO - grabbing minidump binary from tooltool 16:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4d100>, '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 0x2d4e000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:53:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:26 INFO - Return code: 0 16:53:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:27 INFO - Return code: 0 16:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:53:27 INFO - Using env: {'DISPLAY': ':0', 16:53:27 INFO - 'HOME': '/home/cltbld', 16:53:27 INFO - 'LANG': 'en_US.UTF-8', 16:53:27 INFO - 'LANGUAGE': 'en_US:en', 16:53:27 INFO - 'LOGNAME': 'cltbld', 16:53:27 INFO - 'MAIL': '/var/mail/cltbld', 16:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:27 INFO - 'MOZ_NO_REMOTE': '1', 16:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:27 INFO - 'NO_EM_RESTART': '1', 16:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:27 INFO - 'PWD': '/builds/slave/test', 16:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:27 INFO - 'SHELL': '/bin/bash', 16:53:27 INFO - 'SHLVL': '1', 16:53:27 INFO - 'TERM': 'linux', 16:53:27 INFO - 'TMOUT': '86400', 16:53:27 INFO - 'USER': 'cltbld', 16:53:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814', 16:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:27 INFO - '_': '/tools/buildbot/bin/python'} 16:53:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:53:28 INFO - mozversion application_buildid: 20160301152332 16:53:28 INFO - mozversion application_changeset: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd 16:53:28 INFO - mozversion application_display_name: Nightly 16:53:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:28 INFO - mozversion application_name: Firefox 16:53:28 INFO - mozversion application_remotingname: firefox 16:53:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:53:28 INFO - mozversion application_vendor: Mozilla 16:53:28 INFO - mozversion application_version: 47.0a1 16:53:28 INFO - mozversion platform_buildid: 20160301152332 16:53:28 INFO - mozversion platform_changeset: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd 16:53:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:53:28 INFO - mozversion platform_version: 47.0a1 16:53:28 INFO - using testdate: 1456880008 16:53:28 INFO - actual date: 1456880008 16:53:28 INFO - starting webserver on 'localhost:43248' 16:53:28 INFO - SUITE-START | Running 2 tests 16:53:28 INFO - TEST-START | dromaeo_css 16:53:28 INFO - operating with platform_type : linux_ 16:53:28 INFO - Initialising browser for dromaeo_css test... 16:53:28 INFO - TEST-INFO | started process 26305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6h3KlT/profile http://localhost:43248/getInfo.html) 16:53:32 INFO - PROCESS | 26305 | __metrics Screen width/height:1600/1200 16:53:32 INFO - PROCESS | 26305 | colorDepth:24 16:53:32 INFO - PROCESS | 26305 | Browser inner width/height: 1024/697 16:53:32 INFO - PROCESS | 26305 | __metrics 16:53:33 INFO - PROCESS | 26305 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:53:34 INFO - TEST-INFO | 26305: exit 0 16:53:34 INFO - Browser initialized. 16:53:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:34 INFO - TEST-INFO | started process 26400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6h3KlT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:46 INFO - PROCESS | 26400 | RSS: Main: 152793088 16:53:46 INFO - PROCESS | 26400 | 16:54:37 INFO - PROCESS | 26400 | 1456880077973 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] 16:56:48 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43248/tests/dromaeo/cssquery-ext.html) 16:56:49 INFO - PROCESS | 26400 | RSS: Main: 236539904 16:56:49 INFO - PROCESS | 26400 | 16:59:51 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-ext.html (next: http://localhost:43248/tests/dromaeo/cssquery-jquery.html) 16:59:52 INFO - PROCESS | 26400 | RSS: Main: 235884544 16:59:52 INFO - PROCESS | 26400 | 17:02:54 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43248/tests/dromaeo/cssquery-mootools.html) 17:02:54 INFO - PROCESS | 26400 | RSS: Main: 239091712 17:02:54 INFO - PROCESS | 26400 | 17:05:56 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43248/tests/dromaeo/cssquery-prototype.html) 17:05:57 INFO - PROCESS | 26400 | RSS: Main: 220643328 17:05:57 INFO - PROCESS | 26400 | 17:09:00 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43248/tests/dromaeo/cssquery-yui.html) 17:09:00 INFO - PROCESS | 26400 | RSS: Main: 223346688 17:09:00 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | Cycle 1(1): loaded http://localhost:43248/tests/dromaeo/cssquery-yui.html (next: http://localhost:43248/tests/dromaeo/cssquery-dojo.html) 17:12:03 INFO - PROCESS | 26400 | RSS: Main: 295350272 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | __start_tp_report 17:12:03 INFO - PROCESS | 26400 | _x_x_mozilla_page_load 17:12:03 INFO - PROCESS | 26400 | _x_x_mozilla_page_load_details 17:12:03 INFO - PROCESS | 26400 | |i|pagename|runs| 17:12:03 INFO - PROCESS | 26400 | |0;dojo.html;2568.8458692478453;2642.0488624095333;2651.7215692352293;2664.3871909460822;2687.0729598288585;3853.248616519773;3881.6506514413695;3911.882643520692;3922.392029235466;3937.90155246119;3965.0880297531585;4018.2566225248274;4024.094578719794;4056.695747818918;4072.165206132743;3665.6334366563397;3704.611015843338;3712.6658600725927;3749;3814.5803961564206;3762.3039737648487;3794.203217324365;3808.542974843023;3824.445455408964;3827.4641550182996;3569.5716514018222;3679.9080022999638;3724.348239058181;3736.3648179809497;3754.8498060077563;3689.26214757047;3703.166787472797;3706.944395834065;3725.9813700931595;3740.2893450244364;3586.33652774235;3701.0747313171705;3702.37059699849;3714.739968202227;3747.5315585551807;3854.8650797221962;3931.66580840626;3980.044789250559;4008.2985477541315;4017.216642754664;4229.492460904711;4231.8518851840345;4236.491621005499;4254;4262.872113836559;4064.8170832312617;4159.646430053449;4206.957930420687;4242.766647834368;4266.146770645883;3961.2473630010204;3964.147708242684;3994.2211268802594;4000.079981604247;4002.3396139636925;4223.619874211275;4261.275583150872;4266.829326826892;4269.4449721536;4302.182585308781;3972.5431575368625;4161.167766446662;4170.457840480718;4200.558941311179;4252.128313695685;4252.978735106305;4253.957460425418;4257.212415703105;4267.274563324242;4293.763842988666;4184.351425529047;4186.204621121977;4189.183109293658;4190.392393102983;4245.87262382129;3998.6801055915457;4120.484939382577;4183.079722461053;4196.496420429568;4197.244495990751;4066.4510291110914;4071.2875246831686;4072.3484242521054;4073.735207211522;4109.486314210723;3589.784612923233;3592.1558433768046;3595.334863050344;3633.091727068233;3655.780653160819;3966.5240171179644;4040.6565441937178;4128.855490057894;4200.684948628865;4207.410962465257;4202.411662367271;4222.556631553704;4222.894427639334;4223.13425747721;4266.0188156724125;4151.750894946313;4165.042040330741;4168.583141685868;4169.854055108057;4207.116505533872;4138.875833724993;4345.283028300295;4393.428854248928;4414.073044660593;4416.492103408149;4561.315802629632;4570.840020599329;4585.335126406586;4589.05924285514;4630.282306242538;4069.7965101744203;4225.767582782976;4228.9577104228565;4254.425652536992;4267.1892340455215;4516.796744146455;4560.749158796165;4565.54344565554;4569.977150114361;4605.378273932976;4180.498340199196;4195.13999630069;4197.790110494402;4215.262329092336;4234.78826058702;4048.716589838683;4173.373993900939;4225.556316586837;4243.533211346811;4285.507166675872;4094.344904815215;4107.363358679409;4113.9794301028305;4150.79246037703;4158.792060396908;4108.897277568085;4113.4858142732155;4114.382842573638;4130.132672138764;4149;3848.7113466489564;3998.7800670963375;4051.1290072634524;4074.062965517888;4077.327241005201;4063.7764922929523;4066.6136717011836;4073.2590543084557;4109.97945010273;4111.09555897702;3985.222881538072;3999.3201155804163;4004.9399259010556;4018.1963607279245;4043.757374557536 17:12:03 INFO - PROCESS | 26400 | |1;ext.html;477.5463309855638;483.71702554005907;501.5536172806203;507.3024591187118;523.9056969745445;25165.245042648705;25583.872080639594;32790.67209327903;33202.8339858301;33259.83370083146;36506.08734781632;37095.62904370955;37099.44350834733;37115.257694846085;37241.255174896556;7547.24527547245;7713.884291735629;7731.729389471369;7738.877862709904;7739.922600774004;7609.961950190269;7667.8849817252785;7730.111037230706;7741.380689544823;7751.341136003446;7655.885161722578;7760.922390776076;7866.449348545604;7877.842443151134;7909.841803163933;7730.884036739425;7791.532508049479;7811.843763124734;7817.374610031184;7823.10034346049;7688.961555192188;7816.7264145754625;7823.569703666296;7824.726134585262;7825.686972521093;35617.643823561695;35987;36036.27927441463;36049.63950360489;36080.45879311812;2810.7329803668617;2873.396586716792;2934.3837794063274;2945.175350901751;3068.2482791715947;27141.321466963287;27167.86416067907;27631.723682763117;27899;28219.15342539727;3329.583802024747;3365.225998020469;3366.663333666638;3386.475096360068;3431.4681224410256;225648;225801;225960;226960;226966;52143.2178517315;52150.73924630353;52549.7372513135;52555.47444525582;52588.21117683238;60528.69735651294;61172.38827611667;61307.6934615333;61316.69341653263;61367.38632613706;10950.780984380428;11080;11082.667519974413;11093;11113.166512511432;8420.410571259952;8478.957605211934;8480.703175388831;8499;8504.064552899175;18640;18732.063396830104;18822.811771882105;18846.607610629944;19369.225230990884;7229.2047874733735;7370.48406611532;7422.665980030912;7468.663910124057;7500.249975002456;895.8163576466809;914.995425022884;936.3632729743839;938.029139840262;1028.136365453023;25481;26205.344866378495;26379.604305935427;26386.472270554867;26706.19881403561;955.7706150523824;998.6654470752234;1006.6174853555748;1037.9221558383151;1043.9269251152498;13520.459181632821;13750.65623359424;13809.309534523234;13829.239391833546;13939.790903136462;254806;257606;257923;258304;260213;45897.77051114723;46490.76754616273;46531;46553.76723116363;46640.7667961658;1019.3781793106199;1115.8382034604938;1182.2610868207541;1189.2923710392304;1193.6001439517686;23544;24039.51920961536;24338.917896030347;24574.754252457245;26357.34106647349;35949.28101437904;36111.63888361083;36411;36425.271494570494;36453.45319820152;171934;175734;175836;176223;176367.11816440837;23983.640245395985;24497.632535512337;24516.87741561281;24536.38659033467;28165.859170704014;32781.50827737538;33639.3272134551;34059.65940340565;34352.141196470286;34417.13957151091;30632.84683576568;31005.534916975812;31456.213594660316;32084.35831283408;32559.186020348734;31526.054218373487;31649.525257120702;31712.365752684356;31906.36187276288;31945.6805431952;31831.681683183797;32566.185845354055;32870;32957;32960;26993;28723.281917951383;28960.710392895802;29011.41977160403;29174.854125729235;22475.43811404728;22738.65892011654;22831.086756530218;22876.199333023265;23123.76876231216 17:12:03 INFO - PROCESS | 26400 | |2;jquery.html;309.65473497050795;310.69396644305357;317.42545991754923;317.7315168682463;319.3549030957466;14847.925760371183;15021.474248401295;15407.691846163098;15476.3035663395;15487.690246195069;13355.666108347295;13413.530526431578;13714.451421943111;13732.519361822313;13823.377947992365;4800.327954086422;4952.529509696573;4959.156943319645;4979.1784355581285;4981.5018498150075;4724.692894961834;4888.97555512222;4937.358143441347;4942.678725882824;4944.87637809054;4875.098106850226;4886.071646387193;4892.755362231892;4893.04585605807;4897.461279259279;4867.318575399447;4894.828680996148;4896.387951506062;4901.754912254409;4907.681000734959;4289.742615443052;5958.433948774903;6241.65670888101;6255.12428260044;6258.374162583751;19531.609367812565;19604.607907841906;19705.408837734747;20793;20826.271080512262;1988.4233572264027;1996.5807180492113;2064.5457999240293;2268.9109227570693;2363.196513185508;12638.747225055447;12839.358032098358;12923.289219092947;13381.866181338159;13470.326483675875;1847.316492897623;1914.5022294203468;1918.5107797511546;1939.5926855360392;1981.1580078466739;59272;60908.69545652287;61749.6912515439;62283.68858155725;64540.67729661416;14830.480933167288;14846.925765371105;14912.478063267734;14984.47554335593;15194.468193613171;22407;22462.775372246397;22624;22658.206962756223;22678.93834332344;7268.454865884974;7309.780706578811;7412.888806667905;7460.612603966787;7472.364848987897;5976.820695379146;6042.4561789438285;6111.449969502766;6114.510839132859;6139.2325959255095;7321.560706357635;7437.628118594157;7447.590382529013;7474.289942455458;7474.70101195957;2891.349446374591;3067.969320306813;3079.5688603595513;3082.553029810665;3158.1788734928623;808.4825711544617;819.2135549872071;870.1342164546317;870.6125774030622;876.4880580997728;14432.206228657524;14757.040792348464;14834.480793172403;14965.850341496445;15310.693786124215;776.1966364812392;800;820.7783898347532;855.6534603485599;860.6084231674573;8300.667973281;8462.703805366906;8486.236238738544;8547.487150770974;8737.126287371211;357668;371683;372504;373283;373762;51754.48245517497;64091.35908640854;66260.66869665621;66533.66733166303;67973.3202667967;837.5016864965214;868.3400615532241;881.9029906710257;882.9161229683169;883.4566741454088;13196.670083247996;13675.26485720434;13729.725405492034;13793.379297931417;13927.512537061559;30181.09456716302;30570;30678.386432271676;31113.377732444773;31573.684263157993;40634.39048414217;44223.55776442323;46551.76724116358;46596.30105548487;46769.766151169024;6482.675866206765;6643;6826.93173068263;6865.656717164222;6908.585484870723;7950.2906875022145;10554.736131596464;10620.52207650642;10642.84035739449;10774.838377424501;6569.981652843817;6580.473562115115;8984.23633991092;9110.817783644157;9217.44695318283;6357.650329231937;6451.4516266116025;6629.966850165718;6637.966810165918;6678.131842860397;6541.70562324687;6717.395434410926;6800.217974932946;7068.68190931399;7083.0521606558605;9287.164155226063;9621.759456013375;9622.615095396106;9669.516524173623;9683.854742178732;9465.810683786149;9534.284928630519;9545.236381089635;9554.140127388291;9667.419954802734 17:12:03 INFO - PROCESS | 26400 | |3;mootools.html;1144.130460849754;1344.7310537892422;1346.2191928681364;1458.438501177047;1682.5120714992652;6848.863022739549;7010.929890701092;7042.894356584649;7079.008938748567;7093.787186384404;6902.17173939128;7105.5026148169645;7109.324614161659;7112.679929403189;7132.643367831601;1713.2119225156443;1743.8779285450023;1757.4024831557267;2052.199642139563;2077.6156411063926;2028.6247044296779;2079.625667379871;2080.2615071649575;2082.375287413777;2083.624947509448;1978.7625484941755;1994.780574136851;2006.4281679721282;2008.2970960163973;2008.9397318080407;1991.0442987366073;1994.4614953962348;1996.0219492448596;1996.211496458898;1999.0404605789302;1957.559549101455;1977.7626684797772;1980.376181502822;1983.31575606417;1984;7012.614306213207;7040.683169257344;7050.717971281143;7055.047568578228;7056.717731290742;3932.5674175840636;4024.7786371749544;4027.0536423940644;4047.170330082326;4051.6150965658217;2588.9870550647315;2652.5490666586725;2694.1109433886772;2732.3442373830335;2734.5487994481086;851.0383266908416;855.5764896376334;867.6225841758855;883.231588517987;884.2351366068369;9577.425354478753;9577.521123943845;9603.18372938301;9634.614615415376;9639.084286992724;3656.7623104498653;3788.1855401088346;3812.3519001769764;3851.1912498375095;3875.9612403876163;8234.217749313806;8236.135205803304;8259.297959673495;8275.048369437593;8275.54484503358;3945.7237993340764;3963.6630886374405;3978.9403158952637;3979.7015223858325;3984.7808370539897;2951.8524073796225;3524.947125793115;3587.5694916610173;3590.1563132663805;3636.07280143567;3280.0815771583993;3329.983350083234;3356.328734253159;3364.09169524232;3379.0369744622662;961.1925982174866;1014.1075853249093;1022.9693109206736;1032.0092710997526;1044.7753732947453;1107.0534692837668;1115.7210697325668;1121.545773961547;1139.6751925701135;1152.0610702277618;6531.640759758164;6563.474922006228;6574.901376479356;6590.7693230736695;6593.934060659332;408.4812288393723;422.17043509503975;422.48878856583264;425.6339547988727;427.6493275514111;5197.194434862602;5218.452062533455;5237.764300606482;5269.841904742864;5274.525292723597;8369.372297077743;8501.659933602587;8647.783805404915;8655.913440865637;8681.609327580274;8549.487030778173;8553.657853685907;8579.785505362292;8599.226069653636;8634.870476942851;6641.767538136142;6646.26891041985;6770.796876093725;6833.965830170917;6836.487263455161;6395.42441180296;6412.871742565216;6438.227412710505;6461.418472337325;6467.935320646733;7462.776116716507;7486.251374862471;7626.885596716164;7632.847343052997;7763.72826951054;7728.536287822749;7892.802679932818;7968.322692571196;8070.87893681607;8091.06952700447;5202.063628546898;5889.411058894077;6015.789447369321;6034.24571928509;6122.173506576555;6495.610263384212;6596;6646.235682896336;6652.900206497004;6653.767118150841;5851.61964472308;5906.202662640489;5954.37479064692;5975.850603734942;6117.632942023492;5727.627704199213;5740.913886291625;5961.165436838933;6063.120847477179;6152.7538898445355;6206.906896396648;6329.936700633119;6340.1440805490665;6354.650494222862;6358.395952384516;5894.38108998549;5898.498627616701;5935.643861368331;5935.881282374242;5944.464998150187;5990.910136347871;5994.490468310242;6035.758569657164;6052.092186172109;6077.331493535619 17:12:03 INFO - PROCESS | 26400 | |4;prototype.html;271.509924586122;275.54810111417277;280.2964558957018;281.0262440643171;283.62419793773256;4544.886377840556;4569.291759777236;4571.679982401229;4576.999999999992;4639.327297541854;4536.342230376594;4549.431321084864;4550.180967425862;4551.294549344849;4559;3423.161325475256;3529.170644898447;3601.2257364666593;3611.3860643690505;3619.0228638267654;3585.569731632208;3594.3170797548514;3605.134767655757;3605.56733192016;3611.8735844245457;3410.795352278859;3577.302426026926;3583.802890841003;3586.6234045425244;3590.389633762267;3497.772644778094;3579.3199292134673;3589.4974703541525;3594.6225646307153;3599.6400359964055;3189.489681650948;3206.502992036238;3219.500977348515;3223.0492004858625;3233.417984762742;4459.977700111511;4460.8661740147845;4462.4645042594775;4465.352523884051;4465.955340446587;4074.9592504074876;4078.490188726409;4083.4079058536645;4084.8570300039655;4085.407615895708;4700.623950083985;4714.434267887841;4715.08055929094;4728.905421891577;4737.2420412734145;3426.691597756189;3432.1419645088727;3454.11919960411;3460.7058400036026;3471.427214509603;4696.671233013691;4872.269159626049;4885;4892.19278818998;4895.804167833282;3379.4930760386137;3383.8984830454633;3400.1159698478573;3405.642407547172;3408.0627827347676;3430.3482338355634;3449.189440481485;3454.4300190468794;3456.291460250693;3464.8614055438006;3955.8417663293144;3961.088949541622;3965.583613720518;3968.3452230381663;3969.980150099231;4696.107739529479;4739.620830333565;4741;4745.83389581363;4746.454157771831;1195.8983486403754;1210.479493817667;1211.5698926881007;1212.7877621416217;1213.5752486629785;785.6346798738614;826.6486743134144;834.7328854766416;841.1672444280118;852.7654894903951;4768.117898188777;4770.880727981828;4778.426588809365;4792.95207047932;4796.064767370399;4841.298011788271;4846.61227101831;4851.126797176472;4852.975735121302;4853.757312134379;4782.713037217778;4783.808647654125;4785.856424307276;4787.8563643090765;4804.639652026112;2545.910893118732;2571.7942564594787;2574.3564108972755;2576.433184699363;2577.6777902762155;5335.413104558495;5344.3853956795465;5344.599155063386;5346.278252435949;5353.544948679328;4791.880202994953;4968.677035992649;4977.427595826526;4979;4993.775280112403;5318.12250978592;5330.466953304716;5335.813246536431;5342.305500284938;5349.919751203735;4843.975780121077;4846.466888642176;4847.321375007572;4850.320955066223;4851.563359297539;4755.453122890912;4757.476677565396;4757.9048419032115;4763.0473905218405;4773.904521909473;5321.707306098202;5328.626996110235;5330.307060082319;5335.653182543122;5336.546393556591;3365.915852103619;3367.6463971282665;3371.494275858641;3372.9881035689687;3376.5272861798876;4776.832810851603;4842.225243960949;4864.148773964472;4888.144574699484;4930.433000204879;4749.525047495223;4772.594329482033;4773.546513081252;4775.904481910412;4781.784819683053;4766;4767.713937163781;4770.952290477189;4771.045790841776;4780.474147843804;4671.486136524912;4672.883177920579;4674.976625116853;4676.368690226912;4682.625389968726;4797.688150270221;4798.760061996956;4805.255185446262;4806.255030470283;4808.591269741971;4532.320151977098;4692.41344831896;4714.457837348748;4721.598664113451;4726.929096063493 17:12:03 INFO - PROCESS | 26400 | |5;yui.html;650.2197363164203;651.5048563092049;656.2944834303125;664.783945217804;667.1227336053087;10249.641262555811;10373.688789336322;10380.948095259531;10410.219233557485;10413.375197488156;10614.363138211713;10625.734356641087;10628.256022078458;10687.625933092344;10692.78614427713;595.3659352789288;751.6129193465342;773.5706682791049;779.3336697123963;780.2938340801555;767.8502691975067;771.7916162636085;773.8955241042444;774.314731462654;775.1395950494946;803.6142651527271;805.046020465747;806.0810675829559;806.0891192951956;806.5483329335561;620.5128973755603;792.0139426414122;806.5120602035743;808.4704518540366;810.2140923304386;599.2509363295881;599.547341756975;599.9520038396918;599.9940000599981;600.5705920266986;10410.479476026168;10478.738031549196;10483.318584291997;10492.213084018653;10518.316309439862;10471.424071676054;10653;10896.40069796161;11105.777884442266;11267.323960562311;8926.107389261088;8966.237869781076;9146.131117543822;9244.260459163252;9251.814963700755;3056.174832795155;3059.7552195824283;3120.344727607205;3140.638826534932;3174.698403651649;36515.452268215995;37153.44269835955;37257.81371093154;37296.62703372959;37353.252934941695;8279.875801862976;8410.411271210956;8413.621387037598;8420.15798420153;8597.355198360148;13504;13523.120997135155;13603.183808971295;13616;13635.045546811827;5731.197632331477;5993.160957465958;6069.2110025696375;6081.513478921675;6147.754089836446;3460.4481205844995;3462.4806279058344;3466.878659246914;3467.739919506047;3468.0809585459874;2412.7345991940874;2466.6176742604925;2474;2499.9250022499355;2514.0823599386094;445.6390323837637;447.23746013047673;449.81107934667517;452.6378896882481;461.5107985535343;545.2366686638737;559.1333433178557;571.725571725574;573.2204202284889;574.5001848391926;6830.624315662587;7158.355747982707;8177;8230.876536851832;8516.574171291411;491.7000629615931;512.7513156119279;556.2490637639155;573.7680423153935;582.5397935630804;3409.590849098124;3445.4659527772733;3485.546878905777;3521.6654417830264;3748.0817199785683;42087.579124208976;42764;46202;50795;50974.235386469234;44337.77831110824;45154.77422612932;45484.77257613691;45523.54476455259;45546;40643;40853.38719919204;40865.795671022046;41172.970675732744;41364.79317603453;6730.226024007302;6732.562383445061;6829.146356705412;6847.281035491401;6874.243833178246;28933;29204.853975729984;29693.257668558457;29866.552001719556;29895.55156672608;35520.46719299161;35662.28675426529;39466;39908.80045599753;40005.599944001355;8324;8494.193051660082;8556.229939305244;9416.811663766823;9463.858042129512;9829.262805289774;9861.704148875546;10886.891131088587;11349.659510214708;11613.045064131098;10407.791844162923;10763.784724305313;10765.946170269099;10863.619773307897;10934.343939363664;9866;10097.798044038931;10186.949065254626;10303.484825758833;10458.843117353093;10032.046955539212;10057.547410366406;10061;10247.846282305622;10387.896121038995;8496.532690701824;8552.230299273095;8628.39601227933;8803.427777194462;8879.644814207359;9113.225375843127;9220.723378298662;9228.723138305862;9235.07649235071;9248.861267081134 17:12:03 INFO - PROCESS | 26400 | __end_tp_report 17:12:03 INFO - PROCESS | 26400 | __start_cc_report 17:12:03 INFO - PROCESS | 26400 | _x_x_mozilla_cycle_collect,786 17:12:03 INFO - PROCESS | 26400 | __end_cc_report 17:12:03 INFO - PROCESS | 26400 | __startTimestamp1456881123392__endTimestamp 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | ------- Summary: start ------- 17:12:03 INFO - PROCESS | 26400 | Number of tests: 6 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#0] dojo.html Cycles:165 Average:4037.88 Median:4109.49 stddev:339.58 (8.3%) stddev-sans-first:320.48 17:12:03 INFO - PROCESS | 26400 | Values: 2568.8 2642.0 2651.7 2664.4 2687.1 3853.2 3881.7 3911.9 3922.4 3937.9 3965.1 4018.3 4024.1 4056.7 4072.2 3665.6 3704.6 3712.7 3749.0 3814.6 3762.3 3794.2 3808.5 3824.4 3827.5 3569.6 3679.9 3724.3 3736.4 3754.8 3689.3 3703.2 3706.9 3726.0 3740.3 3586.3 3701.1 3702.4 3714.7 3747.5 3854.9 3931.7 3980.0 4008.3 4017.2 4229.5 4231.9 4236.5 4254.0 4262.9 4064.8 4159.6 4207.0 4242.8 4266.1 3961.2 3964.1 3994.2 4000.1 4002.3 4223.6 4261.3 4266.8 4269.4 4302.2 3972.5 4161.2 4170.5 4200.6 4252.1 4253.0 4254.0 4257.2 4267.3 4293.8 4184.4 4186.2 4189.2 4190.4 4245.9 3998.7 4120.5 4183.1 4196.5 4197.2 4066.5 4071.3 4072.3 4073.7 4109.5 3589.8 3592.2 3595.3 3633.1 3655.8 3966.5 4040.7 4128.9 4200.7 4207.4 4202.4 4222.6 4222.9 4223.1 4266.0 4151.8 4165.0 4168.6 4169.9 4207.1 4138.9 4345.3 4393.4 4414.1 4416.5 4561.3 4570.8 4585.3 4589.1 4630.3 4069.8 4225.8 4229.0 4254.4 4267.2 4516.8 4560.7 4565.5 4570.0 4605.4 4180.5 4195.1 4197.8 4215.3 4234.8 4048.7 4173.4 4225.6 4243.5 4285.5 4094.3 4107.4 4114.0 4150.8 4158.8 4108.9 4113.5 4114.4 4130.1 4149.0 3848.7 3998.8 4051.1 4074.1 4077.3 4063.8 4066.6 4073.3 4110.0 4111.1 3985.2 3999.3 4004.9 4018.2 4043.8 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#1] ext.html Cycles:180 Average:37540.36 Median:32913.50 stddev:58018.86 (176.3%) stddev-sans-first:58114.88 17:12:03 INFO - PROCESS | 26400 | Values: 477.5 483.7 501.6 507.3 523.9 25165.2 25583.9 32790.7 33202.8 33259.8 36506.1 37095.6 37099.4 37115.3 37241.3 7547.2 7713.9 7731.7 7738.9 7739.9 7610.0 7667.9 7730.1 7741.4 7751.3 7655.9 7760.9 7866.4 7877.8 7909.8 7730.9 7791.5 7811.8 7817.4 7823.1 7689.0 7816.7 7823.6 7824.7 7825.7 35617.6 35987.0 36036.3 36049.6 36080.5 2810.7 2873.4 2934.4 2945.2 3068.2 27141.3 27167.9 27631.7 27899.0 28219.2 3329.6 3365.2 3366.7 3386.5 3431.5 225648.0 225801.0 225960.0 226960.0 226966.0 52143.2 52150.7 52549.7 52555.5 52588.2 60528.7 61172.4 61307.7 61316.7 61367.4 10950.8 11080.0 11082.7 11093.0 11113.2 8420.4 8479.0 8480.7 8499.0 8504.1 18640.0 18732.1 18822.8 18846.6 19369.2 7229.2 7370.5 7422.7 7468.7 7500.2 895.8 915.0 936.4 938.0 1028.1 25481.0 26205.3 26379.6 26386.5 26706.2 955.8 998.7 1006.6 1037.9 1043.9 13520.5 13750.7 13809.3 13829.2 13939.8 254806.0 257606.0 257923.0 258304.0 260213.0 45897.8 46490.8 46531.0 46553.8 46640.8 1019.4 1115.8 1182.3 1189.3 1193.6 23544.0 24039.5 24338.9 24574.8 26357.3 35949.3 36111.6 36411.0 36425.3 36453.5 171934.0 175734.0 175836.0 176223.0 176367.1 23983.6 24497.6 24516.9 24536.4 28165.9 32781.5 33639.3 34059.7 34352.1 34417.1 30632.8 31005.5 31456.2 32084.4 32559.2 31526.1 31649.5 31712.4 31906.4 31945.7 31831.7 32566.2 32870.0 32957.0 32960.0 26993.0 28723.3 28960.7 29011.4 29174.9 22475.4 22738.7 22831.1 22876.2 23123.8 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#2] jquery.html Cycles:180 Average:22803.36 Median:4899.61 stddev:60695.05 (1238.8%) stddev-sans-first:60841.82 17:12:03 INFO - PROCESS | 26400 | Values: 309.7 310.7 317.4 317.7 319.4 14847.9 15021.5 15407.7 15476.3 15487.7 13355.7 13413.5 13714.5 13732.5 13823.4 4800.3 4952.5 4959.2 4979.2 4981.5 4724.7 4889.0 4937.4 4942.7 4944.9 4875.1 4886.1 4892.8 4893.0 4897.5 4867.3 4894.8 4896.4 4901.8 4907.7 4289.7 5958.4 6241.7 6255.1 6258.4 19531.6 19604.6 19705.4 20793.0 20826.3 1988.4 1996.6 2064.5 2268.9 2363.2 12638.7 12839.4 12923.3 13381.9 13470.3 1847.3 1914.5 1918.5 1939.6 1981.2 59272.0 60908.7 61749.7 62283.7 64540.7 14830.5 14846.9 14912.5 14984.5 15194.5 22407.0 22462.8 22624.0 22658.2 22678.9 7268.5 7309.8 7412.9 7460.6 7472.4 5976.8 6042.5 6111.4 6114.5 6139.2 7321.6 7437.6 7447.6 7474.3 7474.7 2891.3 3068.0 3079.6 3082.6 3158.2 808.5 819.2 870.1 870.6 876.5 14432.2 14757.0 14834.5 14965.9 15310.7 776.2 800.0 820.8 855.7 860.6 8300.7 8462.7 8486.2 8547.5 8737.1 357668.0 371683.0 372504.0 373283.0 373762.0 51754.5 64091.4 66260.7 66533.7 67973.3 837.5 868.3 881.9 882.9 883.5 13196.7 13675.3 13729.7 13793.4 13927.5 30181.1 30570.0 30678.4 31113.4 31573.7 40634.4 44223.6 46551.8 46596.3 46769.8 6482.7 6643.0 6826.9 6865.7 6908.6 7950.3 10554.7 10620.5 10642.8 10774.8 6570.0 6580.5 8984.2 9110.8 9217.4 6357.7 6451.5 6630.0 6638.0 6678.1 6541.7 6717.4 6800.2 7068.7 7083.1 9287.2 9621.8 9622.6 9669.5 9683.9 9465.8 9534.3 9545.2 9554.1 9667.4 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#3] mootools.html Cycles:180 Average:4869.69 Median:5957.77 stddev:2605.12 (43.7%) stddev-sans-first:2597.38 17:12:03 INFO - PROCESS | 26400 | Values: 1144.1 1344.7 1346.2 1458.4 1682.5 6848.9 7010.9 7042.9 7079.0 7093.8 6902.2 7105.5 7109.3 7112.7 7132.6 1713.2 1743.9 1757.4 2052.2 2077.6 2028.6 2079.6 2080.3 2082.4 2083.6 1978.8 1994.8 2006.4 2008.3 2008.9 1991.0 1994.5 1996.0 1996.2 1999.0 1957.6 1977.8 1980.4 1983.3 1984.0 7012.6 7040.7 7050.7 7055.0 7056.7 3932.6 4024.8 4027.1 4047.2 4051.6 2589.0 2652.5 2694.1 2732.3 2734.5 851.0 855.6 867.6 883.2 884.2 9577.4 9577.5 9603.2 9634.6 9639.1 3656.8 3788.2 3812.4 3851.2 3876.0 8234.2 8236.1 8259.3 8275.0 8275.5 3945.7 3963.7 3978.9 3979.7 3984.8 2951.9 3524.9 3587.6 3590.2 3636.1 3280.1 3330.0 3356.3 3364.1 3379.0 961.2 1014.1 1023.0 1032.0 1044.8 1107.1 1115.7 1121.5 1139.7 1152.1 6531.6 6563.5 6574.9 6590.8 6593.9 408.5 422.2 422.5 425.6 427.6 5197.2 5218.5 5237.8 5269.8 5274.5 8369.4 8501.7 8647.8 8655.9 8681.6 8549.5 8553.7 8579.8 8599.2 8634.9 6641.8 6646.3 6770.8 6834.0 6836.5 6395.4 6412.9 6438.2 6461.4 6467.9 7462.8 7486.3 7626.9 7632.8 7763.7 7728.5 7892.8 7968.3 8070.9 8091.1 5202.1 5889.4 6015.8 6034.2 6122.2 6495.6 6596.0 6646.2 6652.9 6653.8 5851.6 5906.2 5954.4 5975.9 6117.6 5727.6 5740.9 5961.2 6063.1 6152.8 6206.9 6329.9 6340.1 6354.7 6358.4 5894.4 5898.5 5935.6 5935.9 5944.5 5990.9 5994.5 6035.8 6052.1 6077.3 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#4] prototype.html Cycles:180 Average:4042.36 Median:4687.52 stddev:1206.05 (25.7%) stddev-sans-first:1175.75 17:12:03 INFO - PROCESS | 26400 | Values: 271.5 275.5 280.3 281.0 283.6 4544.9 4569.3 4571.7 4577.0 4639.3 4536.3 4549.4 4550.2 4551.3 4559.0 3423.2 3529.2 3601.2 3611.4 3619.0 3585.6 3594.3 3605.1 3605.6 3611.9 3410.8 3577.3 3583.8 3586.6 3590.4 3497.8 3579.3 3589.5 3594.6 3599.6 3189.5 3206.5 3219.5 3223.0 3233.4 4460.0 4460.9 4462.5 4465.4 4466.0 4075.0 4078.5 4083.4 4084.9 4085.4 4700.6 4714.4 4715.1 4728.9 4737.2 3426.7 3432.1 3454.1 3460.7 3471.4 4696.7 4872.3 4885.0 4892.2 4895.8 3379.5 3383.9 3400.1 3405.6 3408.1 3430.3 3449.2 3454.4 3456.3 3464.9 3955.8 3961.1 3965.6 3968.3 3970.0 4696.1 4739.6 4741.0 4745.8 4746.5 1195.9 1210.5 1211.6 1212.8 1213.6 785.6 826.6 834.7 841.2 852.8 4768.1 4770.9 4778.4 4793.0 4796.1 4841.3 4846.6 4851.1 4853.0 4853.8 4782.7 4783.8 4785.9 4787.9 4804.6 2545.9 2571.8 2574.4 2576.4 2577.7 5335.4 5344.4 5344.6 5346.3 5353.5 4791.9 4968.7 4977.4 4979.0 4993.8 5318.1 5330.5 5335.8 5342.3 5349.9 4844.0 4846.5 4847.3 4850.3 4851.6 4755.5 4757.5 4757.9 4763.0 4773.9 5321.7 5328.6 5330.3 5335.7 5336.5 3365.9 3367.6 3371.5 3373.0 3376.5 4776.8 4842.2 4864.1 4888.1 4930.4 4749.5 4772.6 4773.5 4775.9 4781.8 4766.0 4767.7 4771.0 4771.0 4780.5 4671.5 4672.9 4675.0 4676.4 4682.6 4797.7 4798.8 4805.3 4806.3 4808.6 4532.3 4692.4 4714.5 4721.6 4726.9 17:12:03 INFO - PROCESS | 26400 | 17:12:03 INFO - PROCESS | 26400 | [#5] yui.html Cycles:180 Average:11626.84 Median:45504.16 stddev:13367.11 (29.4%) stddev-sans-first:13379.19 17:12:03 INFO - PROCESS | 26400 | Values: 650.2 651.5 656.3 664.8 667.1 10249.6 10373.7 10380.9 10410.2 10413.4 10614.4 10625.7 10628.3 10687.6 10692.8 595.4 751.6 773.6 779.3 780.3 767.9 771.8 773.9 774.3 775.1 803.6 805.0 806.1 806.1 806.5 620.5 792.0 806.5 808.5 810.2 599.3 599.5 600.0 600.0 600.6 10410.5 10478.7 10483.3 10492.2 10518.3 10471.4 10653.0 10896.4 11105.8 11267.3 8926.1 8966.2 9146.1 9244.3 9251.8 3056.2 3059.8 3120.3 3140.6 3174.7 36515.5 37153.4 37257.8 37296.6 37353.3 8279.9 8410.4 8413.6 8420.2 8597.4 13504.0 13523.1 13603.2 13616.0 13635.0 5731.2 5993.2 6069.2 6081.5 6147.8 3460.4 3462.5 3466.9 3467.7 3468.1 2412.7 2466.6 2474.0 2499.9 2514.1 445.6 447.2 449.8 452.6 461.5 545.2 559.1 571.7 573.2 574.5 6830.6 7158.4 8177.0 8230.9 8516.6 491.7 512.8 556.2 573.8 582.5 3409.6 3445.5 3485.5 3521.7 3748.1 42087.6 42764.0 46202.0 50795.0 50974.2 44337.8 45154.8 45484.8 45523.5 45546.0 40643.0 40853.4 40865.8 41173.0 41364.8 6730.2 6732.6 6829.1 6847.3 6874.2 28933.0 29204.9 29693.3 29866.6 29895.6 35520.5 35662.3 39466.0 39908.8 40005.6 8324.0 8494.2 8556.2 9416.8 9463.9 9829.3 9861.7 10886.9 11349.7 11613.0 10407.8 10763.8 10765.9 10863.6 10934.3 9866.0 10097.8 10186.9 10303.5 10458.8 10032.0 10057.5 10061.0 10247.8 10387.9 8496.5 8552.2 8628.4 8803.4 8879.6 9113.2 9220.7 9228.7 9235.1 9248.9 17:12:03 INFO - PROCESS | 26400 | -------- Summary: end -------- 17:12:03 INFO - PROCESS | 26400 | 17:12:04 INFO - TEST-INFO | 26400: exit 0 17:12:04 INFO - TEST-OK | dromaeo_css | took 1116013ms 17:12:04 INFO - TEST-START | kraken 17:12:04 INFO - operating with platform_type : linux_ 17:12:04 INFO - Initialising browser for kraken test... 17:12:04 INFO - TEST-INFO | started process 26578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkgf_T/profile http://localhost:43248/getInfo.html) 17:12:08 INFO - PROCESS | 26578 | __metrics Screen width/height:1600/1200 17:12:08 INFO - PROCESS | 26578 | colorDepth:24 17:12:08 INFO - PROCESS | 26578 | Browser inner width/height: 1024/697 17:12:08 INFO - PROCESS | 26578 | __metrics 17:12:09 INFO - PROCESS | 26578 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:09 INFO - PROCESS | 26578 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:12:10 INFO - TEST-INFO | 26578: exit 0 17:12:10 INFO - Browser initialized. 17:12:10 INFO - Running cycle 1/1 for kraken test... 17:12:10 INFO - TEST-INFO | started process 26663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkgf_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:22 INFO - PROCESS | 26663 | RSS: Main: 153444352 17:12:22 INFO - PROCESS | 26663 | 17:12:24 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43248/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:25 INFO - PROCESS | 26663 | RSS: Main: 197197824 17:12:25 INFO - PROCESS | 26663 | 17:12:28 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43248/tests/kraken/driver.html?testName=audio-dft) 17:12:28 INFO - PROCESS | 26663 | RSS: Main: 185925632 17:12:28 INFO - PROCESS | 26663 | 17:12:31 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43248/tests/kraken/driver.html?testName=audio-fft) 17:12:32 INFO - PROCESS | 26663 | RSS: Main: 171651072 17:12:32 INFO - PROCESS | 26663 | 17:12:34 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43248/tests/kraken/driver.html?testName=audio-oscillator) 17:12:35 INFO - PROCESS | 26663 | RSS: Main: 175075328 17:12:35 INFO - PROCESS | 26663 | 17:12:37 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:37 INFO - PROCESS | 26663 | RSS: Main: 174034944 17:12:37 INFO - PROCESS | 26663 | 17:12:40 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43248/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:41 INFO - PROCESS | 26663 | RSS: Main: 176316416 17:12:41 INFO - PROCESS | 26663 | 17:12:45 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43248/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:45 INFO - PROCESS | 26663 | RSS: Main: 175325184 17:12:45 INFO - PROCESS | 26663 | 17:12:48 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43248/tests/kraken/driver.html?testName=json-parse-financial) 17:12:49 INFO - PROCESS | 26663 | RSS: Main: 175046656 17:12:49 INFO - PROCESS | 26663 | 17:12:50 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:51 INFO - PROCESS | 26663 | RSS: Main: 187006976 17:12:51 INFO - PROCESS | 26663 | 17:12:53 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:53 INFO - PROCESS | 26663 | RSS: Main: 185008128 17:12:53 INFO - PROCESS | 26663 | 17:12:56 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:56 INFO - PROCESS | 26663 | RSS: Main: 194723840 17:12:56 INFO - PROCESS | 26663 | 17:12:59 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:59 INFO - PROCESS | 26663 | RSS: Main: 198111232 17:12:59 INFO - PROCESS | 26663 | 17:13:02 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:03 INFO - PROCESS | 26663 | RSS: Main: 198144000 17:13:03 INFO - PROCESS | 26663 | 17:13:04 INFO - PROCESS | 26663 | Cycle 1(1): loaded http://localhost:43248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43248/tests/kraken/driver.html?testName=ai-astar) 17:13:05 INFO - PROCESS | 26663 | RSS: Main: 258494464 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | __start_tp_report 17:13:05 INFO - PROCESS | 26663 | _x_x_mozilla_page_load 17:13:05 INFO - PROCESS | 26663 | _x_x_mozilla_page_load_details 17:13:05 INFO - PROCESS | 26663 | |i|pagename|runs| 17:13:05 INFO - PROCESS | 26663 | |0;ai-astar;114;115;107;113;113;117;103;117;114;117 17:13:05 INFO - PROCESS | 26663 | |1;audio-beat-detection;156;142;164;173;145;163;157;135;181;134 17:13:05 INFO - PROCESS | 26663 | |2;audio-dft;162;162;162;160;161;160;164;161;162;161 17:13:05 INFO - PROCESS | 26663 | |3;audio-fft;75;74;114;98;75;74;73;107;95;74 17:13:05 INFO - PROCESS | 26663 | |4;audio-oscillator;94;95;148;95;95;95;137;96;96;134 17:13:05 INFO - PROCESS | 26663 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 17:13:05 INFO - PROCESS | 26663 | |6;imaging-darkroom;146;147;147;146;147;146;146;146;146;146 17:13:05 INFO - PROCESS | 26663 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;96;95 17:13:05 INFO - PROCESS | 26663 | |8;json-parse-financial;67;68;67;68;67;67;68;82;65;64 17:13:05 INFO - PROCESS | 26663 | |9;json-stringify-tinderbox;72;72;71;72;71;78;70;71;71;74 17:13:05 INFO - PROCESS | 26663 | |10;stanford-crypto-aes;86;86;89;86;84;84;84;85;85;87 17:13:05 INFO - PROCESS | 26663 | |11;stanford-crypto-ccm;126;122;123;129;119;120;127;120;121;139 17:13:05 INFO - PROCESS | 26663 | |12;stanford-crypto-pbkdf2;156;138;149;148;152;138;150;160;153;152 17:13:05 INFO - PROCESS | 26663 | |13;stanford-crypto-sha256-iterative;72;72;71;70;70;70;70;71;69;70 17:13:05 INFO - PROCESS | 26663 | __end_tp_report 17:13:05 INFO - PROCESS | 26663 | __start_cc_report 17:13:05 INFO - PROCESS | 26663 | _x_x_mozilla_cycle_collect,1139 17:13:05 INFO - PROCESS | 26663 | __end_cc_report 17:13:05 INFO - PROCESS | 26663 | __startTimestamp1456881185072__endTimestamp 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | ------- Summary: start ------- 17:13:05 INFO - PROCESS | 26663 | Number of tests: 14 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:4.59 (4.0%) stddev-sans-first:4.86 17:13:05 INFO - PROCESS | 26663 | Values: 114.0 115.0 107.0 113.0 113.0 117.0 103.0 117.0 114.0 117.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:160.00 stddev:15.85 (9.9%) stddev-sans-first:16.80 17:13:05 INFO - PROCESS | 26663 | Values: 156.0 142.0 164.0 173.0 145.0 163.0 157.0 135.0 181.0 134.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 17:13:05 INFO - PROCESS | 26663 | Values: 162.0 162.0 162.0 160.0 161.0 160.0 164.0 161.0 162.0 161.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#3] audio-fft Cycles:10 Average:85.90 Median:74.50 stddev:15.96 (21.4%) stddev-sans-first:16.44 17:13:05 INFO - PROCESS | 26663 | Values: 75.0 74.0 114.0 98.0 75.0 74.0 73.0 107.0 95.0 74.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:21.79 (22.9%) stddev-sans-first:22.47 17:13:05 INFO - PROCESS | 26663 | Values: 94.0 95.0 148.0 95.0 95.0 95.0 137.0 96.0 96.0 134.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:13:05 INFO - PROCESS | 26663 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:13:05 INFO - PROCESS | 26663 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:13:05 INFO - PROCESS | 26663 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:67.50 stddev:4.99 (7.4%) stddev-sans-first:5.27 17:13:05 INFO - PROCESS | 26663 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 68.0 82.0 65.0 64.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:2.30 (3.2%) stddev-sans-first:2.44 17:13:05 INFO - PROCESS | 26663 | Values: 72.0 72.0 71.0 72.0 71.0 78.0 70.0 71.0 71.0 74.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 17:13:05 INFO - PROCESS | 26663 | Values: 86.0 86.0 89.0 86.0 84.0 84.0 84.0 85.0 85.0 87.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:124.50 stddev:6.06 (4.9%) stddev-sans-first:6.41 17:13:05 INFO - PROCESS | 26663 | Values: 126.0 122.0 123.0 129.0 119.0 120.0 127.0 120.0 121.0 139.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.00 stddev:7.03 (4.6%) stddev-sans-first:7.06 17:13:05 INFO - PROCESS | 26663 | Values: 156.0 138.0 149.0 148.0 152.0 138.0 150.0 160.0 153.0 152.0 17:13:05 INFO - PROCESS | 26663 | 17:13:05 INFO - PROCESS | 26663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 17:13:05 INFO - PROCESS | 26663 | Values: 72.0 72.0 71.0 70.0 70.0 70.0 70.0 71.0 69.0 70.0 17:13:05 INFO - PROCESS | 26663 | -------- Summary: end -------- 17:13:05 INFO - PROCESS | 26663 | 17:13:06 INFO - TEST-INFO | 26663: exit 0 17:13:06 INFO - TEST-OK | kraken | took 61917ms 17:13:06 INFO - SUITE-END | took 1177s 17:13:06 INFO - Completed test suite (00:19:38) 17:13:06 INFO - Working with test: dromaeo_css 17:13:06 INFO - Generating results file: dromaeo_css 17:13:06 INFO - Working with test: kraken 17:13:06 INFO - Generating results file: kraken 17:13:06 INFO - javascript benchmark 17:13:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:13:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 17:13:06 INFO - process_Request line: dromaeo_css 5840.25 graph.html#tests=[[72,94,35]] 17:13:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:13:06 INFO - process_Request line: kraken 1553.20 graph.html#tests=[[232,94,35]] 17:13:06 INFO - RETURN: dromaeo_css: 5840.25 17:13:06 INFO - RETURN: kraken: 1553.20 17:13:06 INFO - javascript benchmark 17:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2568.8458692478453, 2642.0488624095333, 2651.7215692352293, 2664.3871909460822, 2687.0729598288585, 3853.248616519773, 3881.6506514413695, 3911.882643520692, 3922.392029235466, 3937.90155246119, 3965.0880297531585, 4018.2566225248274, 4024.094578719794, 4056.695747818918, 4072.165206132743, 3665.6334366563397, 3704.611015843338, 3712.6658600725927, 3749.0, 3814.5803961564206, 3762.3039737648487, 3794.203217324365, 3808.542974843023, 3824.445455408964, 3827.4641550182996, 3569.5716514018222, 3679.9080022999638, 3724.348239058181, 3736.3648179809497, 3754.8498060077563, 3689.26214757047, 3703.166787472797, 3706.944395834065, 3725.9813700931595, 3740.2893450244364, 3586.33652774235, 3701.0747313171705, 3702.37059699849, 3714.739968202227, 3747.5315585551807, 3854.8650797221962, 3931.66580840626, 3980.044789250559, 4008.2985477541315, 4017.216642754664, 4229.492460904711, 4231.8518851840345, 4236.491621005499, 4254.0, 4262.872113836559, 4064.8170832312617, 4159.646430053449, 4206.957930420687, 4242.766647834368, 4266.146770645883, 3961.2473630010204, 3964.147708242684, 3994.2211268802594, 4000.079981604247, 4002.3396139636925, 4223.619874211275, 4261.275583150872, 4266.829326826892, 4269.4449721536, 4302.182585308781, 3972.5431575368625, 4161.167766446662, 4170.457840480718, 4200.558941311179, 4252.128313695685, 4252.978735106305, 4253.957460425418, 4257.212415703105, 4267.274563324242, 4293.763842988666, 4184.351425529047, 4186.204621121977, 4189.183109293658, 4190.392393102983, 4245.87262382129, 3998.6801055915457, 4120.484939382577, 4183.079722461053, 4196.496420429568, 4197.244495990751, 4066.4510291110914, 4071.2875246831686, 4072.3484242521054, 4073.735207211522, 4109.486314210723, 3589.784612923233, 3592.1558433768046, 3595.334863050344, 3633.091727068233, 3655.780653160819, 3966.5240171179644, 4040.6565441937178, 4128.855490057894, 4200.684948628865, 4207.410962465257, 4202.411662367271, 4222.556631553704, 4222.894427639334, 4223.13425747721, 4266.0188156724125, 4151.750894946313, 4165.042040330741, 4168.583141685868, 4169.854055108057, 4207.116505533872, 4138.875833724993, 4345.283028300295, 4393.428854248928, 4414.073044660593, 4416.492103408149, 4561.315802629632, 4570.840020599329, 4585.335126406586, 4589.05924285514, 4630.282306242538, 4069.7965101744203, 4225.767582782976, 4228.9577104228565, 4254.425652536992, 4267.1892340455215, 4516.796744146455, 4560.749158796165, 4565.54344565554, 4569.977150114361, 4605.378273932976, 4180.498340199196, 4195.13999630069, 4197.790110494402, 4215.262329092336, 4234.78826058702, 4048.716589838683, 4173.373993900939, 4225.556316586837, 4243.533211346811, 4285.507166675872, 4094.344904815215, 4107.363358679409, 4113.9794301028305, 4150.79246037703, 4158.792060396908, 4108.897277568085, 4113.4858142732155, 4114.382842573638, 4130.132672138764, 4149.0, 3848.7113466489564, 3998.7800670963375, 4051.1290072634524, 4074.062965517888, 4077.327241005201, 4063.7764922929523, 4066.6136717011836, 4073.2590543084557, 4109.97945010273, 4111.09555897702, 3985.222881538072, 3999.3201155804163, 4004.9399259010556, 4018.1963607279245, 4043.757374557536], "unit": "score", "name": "dojo.html", "value": 4021.823623076766}, {"lowerIsBetter": false, "replicates": [477.5463309855638, 483.71702554005907, 501.5536172806203, 507.3024591187118, 523.9056969745445, 25165.245042648705, 25583.872080639594, 32790.67209327903, 33202.8339858301, 33259.83370083146, 36506.08734781632, 37095.62904370955, 37099.44350834733, 37115.257694846085, 37241.255174896556, 7547.24527547245, 7713.884291735629, 7731.729389471369, 7738.877862709904, 7739.922600774004, 7609.961950190269, 7667.8849817252785, 7730.111037230706, 7741.380689544823, 7751.341136003446, 7655.885161722578, 7760.922390776076, 7866.449348545604, 7877.842443151134, 7909.841803163933, 7730.884036739425, 7791.532508049479, 7811.843763124734, 7817.374610031184, 7823.10034346049, 7688.961555192188, 7816.7264145754625, 7823.569703666296, 7824.726134585262, 7825.686972521093, 35617.643823561695, 35987.0, 36036.27927441463, 36049.63950360489, 36080.45879311812, 2810.7329803668617, 2873.396586716792, 2934.3837794063274, 2945.175350901751, 3068.2482791715947, 27141.321466963287, 27167.86416067907, 27631.723682763117, 27899.0, 28219.15342539727, 3329.583802024747, 3365.225998020469, 3366.663333666638, 3386.475096360068, 3431.4681224410256, 225648.0, 225801.0, 225960.0, 226960.0, 226966.0, 52143.2178517315, 52150.73924630353, 52549.7372513135, 52555.47444525582, 52588.21117683238, 60528.69735651294, 61172.38827611667, 61307.6934615333, 61316.69341653263, 61367.38632613706, 10950.780984380428, 11080.0, 11082.667519974413, 11093.0, 11113.166512511432, 8420.410571259952, 8478.957605211934, 8480.703175388831, 8499.0, 8504.064552899175, 18640.0, 18732.063396830104, 18822.811771882105, 18846.607610629944, 19369.225230990884, 7229.2047874733735, 7370.48406611532, 7422.665980030912, 7468.663910124057, 7500.249975002456, 895.8163576466809, 914.995425022884, 936.3632729743839, 938.029139840262, 1028.136365453023, 25481.0, 26205.344866378495, 26379.604305935427, 26386.472270554867, 26706.19881403561, 955.7706150523824, 998.6654470752234, 1006.6174853555748, 1037.9221558383151, 1043.9269251152498, 13520.459181632821, 13750.65623359424, 13809.309534523234, 13829.239391833546, 13939.790903136462, 254806.0, 257606.0, 257923.0, 258304.0, 260213.0, 45897.77051114723, 46490.76754616273, 46531.0, 46553.76723116363, 46640.7667961658, 1019.3781793106199, 1115.8382034604938, 1182.2610868207541, 1189.2923710392304, 1193.6001439517686, 23544.0, 24039.51920961536, 24338.917896030347, 24574.754252457245, 26357.34106647349, 35949.28101437904, 36111.63888361083, 36411.0, 36425.271494570494, 36453.45319820152, 171934.0, 175734.0, 175836.0, 176223.0, 176367.11816440837, 23983.640245395985, 24497.632535512337, 24516.87741561281, 24536.38659033467, 28165.859170704014, 32781.50827737538, 33639.3272134551, 34059.65940340565, 34352.141196470286, 34417.13957151091, 30632.84683576568, 31005.534916975812, 31456.213594660316, 32084.35831283408, 32559.186020348734, 31526.054218373487, 31649.525257120702, 31712.365752684356, 31906.36187276288, 31945.6805431952, 31831.681683183797, 32566.185845354055, 32870.0, 32957.0, 32960.0, 26993.0, 28723.281917951383, 28960.710392895802, 29011.41977160403, 29174.854125729235, 22475.43811404728, 22738.65892011654, 22831.086756530218, 22876.199333023265, 23123.76876231216], "unit": "score", "name": "ext.html", "value": 15936.923640283654}, {"lowerIsBetter": false, "replicates": [309.65473497050795, 310.69396644305357, 317.42545991754923, 317.7315168682463, 319.3549030957466, 14847.925760371183, 15021.474248401295, 15407.691846163098, 15476.3035663395, 15487.690246195069, 13355.666108347295, 13413.530526431578, 13714.451421943111, 13732.519361822313, 13823.377947992365, 4800.327954086422, 4952.529509696573, 4959.156943319645, 4979.1784355581285, 4981.5018498150075, 4724.692894961834, 4888.97555512222, 4937.358143441347, 4942.678725882824, 4944.87637809054, 4875.098106850226, 4886.071646387193, 4892.755362231892, 4893.04585605807, 4897.461279259279, 4867.318575399447, 4894.828680996148, 4896.387951506062, 4901.754912254409, 4907.681000734959, 4289.742615443052, 5958.433948774903, 6241.65670888101, 6255.12428260044, 6258.374162583751, 19531.609367812565, 19604.607907841906, 19705.408837734747, 20793.0, 20826.271080512262, 1988.4233572264027, 1996.5807180492113, 2064.5457999240293, 2268.9109227570693, 2363.196513185508, 12638.747225055447, 12839.358032098358, 12923.289219092947, 13381.866181338159, 13470.326483675875, 1847.316492897623, 1914.5022294203468, 1918.5107797511546, 1939.5926855360392, 1981.1580078466739, 59272.0, 60908.69545652287, 61749.6912515439, 62283.68858155725, 64540.67729661416, 14830.480933167288, 14846.925765371105, 14912.478063267734, 14984.47554335593, 15194.468193613171, 22407.0, 22462.775372246397, 22624.0, 22658.206962756223, 22678.93834332344, 7268.454865884974, 7309.780706578811, 7412.888806667905, 7460.612603966787, 7472.364848987897, 5976.820695379146, 6042.4561789438285, 6111.449969502766, 6114.510839132859, 6139.2325959255095, 7321.560706357635, 7437.628118594157, 7447.590382529013, 7474.289942455458, 7474.70101195957, 2891.349446374591, 3067.969320306813, 3079.5688603595513, 3082.553029810665, 3158.1788734928623, 808.4825711544617, 819.2135549872071, 870.1342164546317, 870.6125774030622, 876.4880580997728, 14432.206228657524, 14757.040792348464, 14834.480793172403, 14965.850341496445, 15310.693786124215, 776.1966364812392, 800.0, 820.7783898347532, 855.6534603485599, 860.6084231674573, 8300.667973281, 8462.703805366906, 8486.236238738544, 8547.487150770974, 8737.126287371211, 357668.0, 371683.0, 372504.0, 373283.0, 373762.0, 51754.48245517497, 64091.35908640854, 66260.66869665621, 66533.66733166303, 67973.3202667967, 837.5016864965214, 868.3400615532241, 881.9029906710257, 882.9161229683169, 883.4566741454088, 13196.670083247996, 13675.26485720434, 13729.725405492034, 13793.379297931417, 13927.512537061559, 30181.09456716302, 30570.0, 30678.386432271676, 31113.377732444773, 31573.684263157993, 40634.39048414217, 44223.55776442323, 46551.76724116358, 46596.30105548487, 46769.766151169024, 6482.675866206765, 6643.0, 6826.93173068263, 6865.656717164222, 6908.585484870723, 7950.2906875022145, 10554.736131596464, 10620.52207650642, 10642.84035739449, 10774.838377424501, 6569.981652843817, 6580.473562115115, 8984.23633991092, 9110.817783644157, 9217.44695318283, 6357.650329231937, 6451.4516266116025, 6629.966850165718, 6637.966810165918, 6678.131842860397, 6541.70562324687, 6717.395434410926, 6800.217974932946, 7068.68190931399, 7083.0521606558605, 9287.164155226063, 9621.759456013375, 9622.615095396106, 9669.516524173623, 9683.854742178732, 9465.810683786149, 9534.284928630519, 9545.236381089635, 9554.140127388291, 9667.419954802734], "unit": "score", "name": "jquery.html", "value": 8039.798541076737}, {"lowerIsBetter": false, "replicates": [1144.130460849754, 1344.7310537892422, 1346.2191928681364, 1458.438501177047, 1682.5120714992652, 6848.863022739549, 7010.929890701092, 7042.894356584649, 7079.008938748567, 7093.787186384404, 6902.17173939128, 7105.5026148169645, 7109.324614161659, 7112.679929403189, 7132.643367831601, 1713.2119225156443, 1743.8779285450023, 1757.4024831557267, 2052.199642139563, 2077.6156411063926, 2028.6247044296779, 2079.625667379871, 2080.2615071649575, 2082.375287413777, 2083.624947509448, 1978.7625484941755, 1994.780574136851, 2006.4281679721282, 2008.2970960163973, 2008.9397318080407, 1991.0442987366073, 1994.4614953962348, 1996.0219492448596, 1996.211496458898, 1999.0404605789302, 1957.559549101455, 1977.7626684797772, 1980.376181502822, 1983.31575606417, 1984.0, 7012.614306213207, 7040.683169257344, 7050.717971281143, 7055.047568578228, 7056.717731290742, 3932.5674175840636, 4024.7786371749544, 4027.0536423940644, 4047.170330082326, 4051.6150965658217, 2588.9870550647315, 2652.5490666586725, 2694.1109433886772, 2732.3442373830335, 2734.5487994481086, 851.0383266908416, 855.5764896376334, 867.6225841758855, 883.231588517987, 884.2351366068369, 9577.425354478753, 9577.521123943845, 9603.18372938301, 9634.614615415376, 9639.084286992724, 3656.7623104498653, 3788.1855401088346, 3812.3519001769764, 3851.1912498375095, 3875.9612403876163, 8234.217749313806, 8236.135205803304, 8259.297959673495, 8275.048369437593, 8275.54484503358, 3945.7237993340764, 3963.6630886374405, 3978.9403158952637, 3979.7015223858325, 3984.7808370539897, 2951.8524073796225, 3524.947125793115, 3587.5694916610173, 3590.1563132663805, 3636.07280143567, 3280.0815771583993, 3329.983350083234, 3356.328734253159, 3364.09169524232, 3379.0369744622662, 961.1925982174866, 1014.1075853249093, 1022.9693109206736, 1032.0092710997526, 1044.7753732947453, 1107.0534692837668, 1115.7210697325668, 1121.545773961547, 1139.6751925701135, 1152.0610702277618, 6531.640759758164, 6563.474922006228, 6574.901376479356, 6590.7693230736695, 6593.934060659332, 408.4812288393723, 422.17043509503975, 422.48878856583264, 425.6339547988727, 427.6493275514111, 5197.194434862602, 5218.452062533455, 5237.764300606482, 5269.841904742864, 5274.525292723597, 8369.372297077743, 8501.659933602587, 8647.783805404915, 8655.913440865637, 8681.609327580274, 8549.487030778173, 8553.657853685907, 8579.785505362292, 8599.226069653636, 8634.870476942851, 6641.767538136142, 6646.26891041985, 6770.796876093725, 6833.965830170917, 6836.487263455161, 6395.42441180296, 6412.871742565216, 6438.227412710505, 6461.418472337325, 6467.935320646733, 7462.776116716507, 7486.251374862471, 7626.885596716164, 7632.847343052997, 7763.72826951054, 7728.536287822749, 7892.802679932818, 7968.322692571196, 8070.87893681607, 8091.06952700447, 5202.063628546898, 5889.411058894077, 6015.789447369321, 6034.24571928509, 6122.173506576555, 6495.610263384212, 6596.0, 6646.235682896336, 6652.900206497004, 6653.767118150841, 5851.61964472308, 5906.202662640489, 5954.37479064692, 5975.850603734942, 6117.632942023492, 5727.627704199213, 5740.913886291625, 5961.165436838933, 6063.120847477179, 6152.7538898445355, 6206.906896396648, 6329.936700633119, 6340.1440805490665, 6354.650494222862, 6358.395952384516, 5894.38108998549, 5898.498627616701, 5935.643861368331, 5935.881282374242, 5944.464998150187, 5990.910136347871, 5994.490468310242, 6035.758569657164, 6052.092186172109, 6077.331493535619], "unit": "score", "name": "mootools.html", "value": 3900.393619956611}, {"lowerIsBetter": false, "replicates": [271.509924586122, 275.54810111417277, 280.2964558957018, 281.0262440643171, 283.62419793773256, 4544.886377840556, 4569.291759777236, 4571.679982401229, 4576.999999999992, 4639.327297541854, 4536.342230376594, 4549.431321084864, 4550.180967425862, 4551.294549344849, 4559.0, 3423.161325475256, 3529.170644898447, 3601.2257364666593, 3611.3860643690505, 3619.0228638267654, 3585.569731632208, 3594.3170797548514, 3605.134767655757, 3605.56733192016, 3611.8735844245457, 3410.795352278859, 3577.302426026926, 3583.802890841003, 3586.6234045425244, 3590.389633762267, 3497.772644778094, 3579.3199292134673, 3589.4974703541525, 3594.6225646307153, 3599.6400359964055, 3189.489681650948, 3206.502992036238, 3219.500977348515, 3223.0492004858625, 3233.417984762742, 4459.977700111511, 4460.8661740147845, 4462.4645042594775, 4465.352523884051, 4465.955340446587, 4074.9592504074876, 4078.490188726409, 4083.4079058536645, 4084.8570300039655, 4085.407615895708, 4700.623950083985, 4714.434267887841, 4715.08055929094, 4728.905421891577, 4737.2420412734145, 3426.691597756189, 3432.1419645088727, 3454.11919960411, 3460.7058400036026, 3471.427214509603, 4696.671233013691, 4872.269159626049, 4885.0, 4892.19278818998, 4895.804167833282, 3379.4930760386137, 3383.8984830454633, 3400.1159698478573, 3405.642407547172, 3408.0627827347676, 3430.3482338355634, 3449.189440481485, 3454.4300190468794, 3456.291460250693, 3464.8614055438006, 3955.8417663293144, 3961.088949541622, 3965.583613720518, 3968.3452230381663, 3969.980150099231, 4696.107739529479, 4739.620830333565, 4741.0, 4745.83389581363, 4746.454157771831, 1195.8983486403754, 1210.479493817667, 1211.5698926881007, 1212.7877621416217, 1213.5752486629785, 785.6346798738614, 826.6486743134144, 834.7328854766416, 841.1672444280118, 852.7654894903951, 4768.117898188777, 4770.880727981828, 4778.426588809365, 4792.95207047932, 4796.064767370399, 4841.298011788271, 4846.61227101831, 4851.126797176472, 4852.975735121302, 4853.757312134379, 4782.713037217778, 4783.808647654125, 4785.856424307276, 4787.8563643090765, 4804.639652026112, 2545.910893118732, 2571.7942564594787, 2574.3564108972755, 2576.433184699363, 2577.6777902762155, 5335.413104558495, 5344.3853956795465, 5344.599155063386, 5346.278252435949, 5353.544948679328, 4791.880202994953, 4968.677035992649, 4977.427595826526, 4979.0, 4993.775280112403, 5318.12250978592, 5330.466953304716, 5335.813246536431, 5342.305500284938, 5349.919751203735, 4843.975780121077, 4846.466888642176, 4847.321375007572, 4850.320955066223, 4851.563359297539, 4755.453122890912, 4757.476677565396, 4757.9048419032115, 4763.0473905218405, 4773.904521909473, 5321.707306098202, 5328.626996110235, 5330.307060082319, 5335.653182543122, 5336.546393556591, 3365.915852103619, 3367.6463971282665, 3371.494275858641, 3372.9881035689687, 3376.5272861798876, 4776.832810851603, 4842.225243960949, 4864.148773964472, 4888.144574699484, 4930.433000204879, 4749.525047495223, 4772.594329482033, 4773.546513081252, 4775.904481910412, 4781.784819683053, 4766.0, 4767.713937163781, 4770.952290477189, 4771.045790841776, 4780.474147843804, 4671.486136524912, 4672.883177920579, 4674.976625116853, 4676.368690226912, 4682.625389968726, 4797.688150270221, 4798.760061996956, 4805.255185446262, 4806.255030470283, 4808.591269741971, 4532.320151977098, 4692.41344831896, 4714.457837348748, 4721.598664113451, 4726.929096063493], "unit": "score", "name": "prototype.html", "value": 3656.516319787638}, {"lowerIsBetter": false, "replicates": [650.2197363164203, 651.5048563092049, 656.2944834303125, 664.783945217804, 667.1227336053087, 10249.641262555811, 10373.688789336322, 10380.948095259531, 10410.219233557485, 10413.375197488156, 10614.363138211713, 10625.734356641087, 10628.256022078458, 10687.625933092344, 10692.78614427713, 595.3659352789288, 751.6129193465342, 773.5706682791049, 779.3336697123963, 780.2938340801555, 767.8502691975067, 771.7916162636085, 773.8955241042444, 774.314731462654, 775.1395950494946, 803.6142651527271, 805.046020465747, 806.0810675829559, 806.0891192951956, 806.5483329335561, 620.5128973755603, 792.0139426414122, 806.5120602035743, 808.4704518540366, 810.2140923304386, 599.2509363295881, 599.547341756975, 599.9520038396918, 599.9940000599981, 600.5705920266986, 10410.479476026168, 10478.738031549196, 10483.318584291997, 10492.213084018653, 10518.316309439862, 10471.424071676054, 10653.0, 10896.40069796161, 11105.777884442266, 11267.323960562311, 8926.107389261088, 8966.237869781076, 9146.131117543822, 9244.260459163252, 9251.814963700755, 3056.174832795155, 3059.7552195824283, 3120.344727607205, 3140.638826534932, 3174.698403651649, 36515.452268215995, 37153.44269835955, 37257.81371093154, 37296.62703372959, 37353.252934941695, 8279.875801862976, 8410.411271210956, 8413.621387037598, 8420.15798420153, 8597.355198360148, 13504.0, 13523.120997135155, 13603.183808971295, 13616.0, 13635.045546811827, 5731.197632331477, 5993.160957465958, 6069.2110025696375, 6081.513478921675, 6147.754089836446, 3460.4481205844995, 3462.4806279058344, 3466.878659246914, 3467.739919506047, 3468.0809585459874, 2412.7345991940874, 2466.6176742604925, 2474.0, 2499.9250022499355, 2514.0823599386094, 445.6390323837637, 447.23746013047673, 449.81107934667517, 452.6378896882481, 461.5107985535343, 545.2366686638737, 559.1333433178557, 571.725571725574, 573.2204202284889, 574.5001848391926, 6830.624315662587, 7158.355747982707, 8177.0, 8230.876536851832, 8516.574171291411, 491.7000629615931, 512.7513156119279, 556.2490637639155, 573.7680423153935, 582.5397935630804, 3409.590849098124, 3445.4659527772733, 3485.546878905777, 3521.6654417830264, 3748.0817199785683, 42087.579124208976, 42764.0, 46202.0, 50795.0, 50974.235386469234, 44337.77831110824, 45154.77422612932, 45484.77257613691, 45523.54476455259, 45546.0, 40643.0, 40853.38719919204, 40865.795671022046, 41172.970675732744, 41364.79317603453, 6730.226024007302, 6732.562383445061, 6829.146356705412, 6847.281035491401, 6874.243833178246, 28933.0, 29204.853975729984, 29693.257668558457, 29866.552001719556, 29895.55156672608, 35520.46719299161, 35662.28675426529, 39466.0, 39908.80045599753, 40005.599944001355, 8324.0, 8494.193051660082, 8556.229939305244, 9416.811663766823, 9463.858042129512, 9829.262805289774, 9861.704148875546, 10886.891131088587, 11349.659510214708, 11613.045064131098, 10407.791844162923, 10763.784724305313, 10765.946170269099, 10863.619773307897, 10934.343939363664, 9866.0, 10097.798044038931, 10186.949065254626, 10303.484825758833, 10458.843117353093, 10032.046955539212, 10057.547410366406, 10061.0, 10247.846282305622, 10387.896121038995, 8496.532690701824, 8552.230299273095, 8628.39601227933, 8803.427777194462, 8879.644814207359, 9113.225375843127, 9220.723378298662, 9228.723138305862, 9235.07649235071, 9248.861267081134], "unit": "score", "name": "yui.html", "value": 5398.693904639137}], "name": "dromaeo_css", "value": 5840.255231990111}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 115.0, 107.0, 113.0, 113.0, 117.0, 103.0, 117.0, 114.0, 117.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [156.0, 142.0, 164.0, 173.0, 145.0, 163.0, 157.0, 135.0, 181.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 160.0, 164.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 114.0, 98.0, 75.0, 74.0, 73.0, 107.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 148.0, 95.0, 95.0, 95.0, 137.0, 96.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 82.0, 65.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 68.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 71.0, 78.0, 70.0, 71.0, 71.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.2}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 89.0, 86.0, 84.0, 84.0, 84.0, 85.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 123.0, 129.0, 119.0, 120.0, 127.0, 120.0, 121.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [156.0, 138.0, 149.0, 148.0, 152.0, 138.0, 150.0, 160.0, 153.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 70.0, 70.0, 70.0, 70.0, 71.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1553.1999999999996}]} 17:13:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1553.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5840.25"}}} 17:13:06 INFO - Return code: 0 17:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:06 INFO - # TBPL SUCCESS # 17:13:06 INFO - Running post-action listener: _resource_record_post_action 17:13:06 INFO - Running post-run listener: _resource_record_post_run 17:13:07 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540241920; Read time: 24; Write time: 846868 17:13:07 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 248668160; Read time: 0; Write time: 532732 17:13:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287637504; Read time: 24; Write time: 313132 17:13:07 INFO - Running post-run listener: _upload_blobber_files 17:13:07 INFO - Blob upload gear active. 17:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13: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 17:13: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'] 17:13: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 17:13:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:08 INFO - (blobuploader) - INFO - Done attempting. 17:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:09 INFO - (blobuploader) - INFO - Done attempting. 17:13:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:09 INFO - Return code: 0 17:13:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/728304cfb94e129fff49860c643dd40ac04bd8f4771e0ed9a775913d2fb06c96a19124b179d57d3f047ea31a0216ef544d73cecbb8bde40ec501b6f1e11a6a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a105f9790425ae820ac1a134970b1f11cbfedb9b728da0e68baf353f95903b55c3873615d2a6ba8831858c211525e03ac409cde948aaaa8c75766e570cb9ff85"} 17:13:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:09 INFO - Contents: 17:13:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/728304cfb94e129fff49860c643dd40ac04bd8f4771e0ed9a775913d2fb06c96a19124b179d57d3f047ea31a0216ef544d73cecbb8bde40ec501b6f1e11a6a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a105f9790425ae820ac1a134970b1f11cbfedb9b728da0e68baf353f95903b55c3873615d2a6ba8831858c211525e03ac409cde948aaaa8c75766e570cb9ff85"} 17:13:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:09 INFO - Copying logs to upload dir... 17:13:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.980218 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 17:13:09.661274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 17:13:09.664614) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/728304cfb94e129fff49860c643dd40ac04bd8f4771e0ed9a775913d2fb06c96a19124b179d57d3f047ea31a0216ef544d73cecbb8bde40ec501b6f1e11a6a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a105f9790425ae820ac1a134970b1f11cbfedb9b728da0e68baf353f95903b55c3873615d2a6ba8831858c211525e03ac409cde948aaaa8c75766e570cb9ff85"} build_url:https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/cVsU-0gOR8iHGY1c4DSwAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/728304cfb94e129fff49860c643dd40ac04bd8f4771e0ed9a775913d2fb06c96a19124b179d57d3f047ea31a0216ef544d73cecbb8bde40ec501b6f1e11a6a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a105f9790425ae820ac1a134970b1f11cbfedb9b728da0e68baf353f95903b55c3873615d2a6ba8831858c211525e03ac409cde948aaaa8c75766e570cb9ff85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 17:13:09.689903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:13:09.690261) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1456879334.329976-2120325814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:13:09.744918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 17:13:09.745270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 17:13:09.745584) ========= ========= Total master_lag: 0.28 =========