builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1449352914.01 results: success (0) buildid: 20151205122329 builduid: 1ca0b8ce67cb48548d4d133cec0f76e9 revision: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.010139) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.010556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.010871) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.035546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.035857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.049984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.050325) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.102895) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.103215) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.103602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.103900) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 14:01:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-05 14:01:54 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.294593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.295043) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.346380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.346734) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 --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 fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 --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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 14:01:54,874 truncating revision to first 12 chars 2015-12-05 14:01:54,874 Setting DEBUG logging. 2015-12-05 14:01:54,874 attempt 1/10 2015-12-05 14:01:54,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb4801cfdbbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 14:01:55,142 unpacking tar archive at: mozilla-central-fb4801cfdbbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:55.091085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:55.091660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:55.103535) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:55.104097) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:55.104575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-05 14:01:55.104897) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:55 INFO - MultiFileLogger online at 20151205 14:01:55 in /builds/slave/test 14:01:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:01:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:55 INFO - {'append_to_log': False, 14:01:55 INFO - 'base_work_dir': '/builds/slave/test', 14:01:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:01:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:55 INFO - 'branch': 'Firefox-Non-PGO', 14:01:55 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:55 INFO - 'config_files': ('talos/linux_config.py',), 14:01:55 INFO - 'default_actions': ('clobber', 14:01:55 INFO - 'read-buildbot-config', 14:01:55 INFO - 'download-and-extract', 14:01:55 INFO - 'populate-webroot', 14:01:55 INFO - 'create-virtualenv', 14:01:55 INFO - 'install', 14:01:55 INFO - 'run-tests'), 14:01:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:55 INFO - 'download_minidump_stackwalk': True, 14:01:55 INFO - 'download_symbols': 'ondemand', 14:01:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:55 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:55 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:55 INFO - 'installer_path': 'installer.exe', 14:01:55 INFO - 'log_level': 'info', 14:01:55 INFO - 'log_name': 'talos', 14:01:55 INFO - 'log_to_console': True, 14:01:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:55 INFO - 'opt_config_files': (), 14:01:55 INFO - 'pip_index': False, 14:01:55 INFO - 'sps_profile': False, 14:01:55 INFO - 'sps_profile_interval': 0, 14:01:55 INFO - 'suite': 'dromaeojs-e10s', 14:01:55 INFO - 'system_bits': '64', 14:01:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:55 INFO - 'title': 'talos-linux64-ix-032', 14:01:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:55 INFO - 'use_talos_json': True, 14:01:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:55 INFO - 'work_dir': 'build'} 14:01:55 INFO - ##### 14:01:55 INFO - ##### Running clobber step. 14:01:55 INFO - ##### 14:01:55 INFO - Running pre-action listener: _resource_record_pre_action 14:01:55 INFO - Running main action method: clobber 14:01:55 INFO - rmtree: /builds/slave/test/build 14:01:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:56 INFO - Running post-action listener: _resource_record_post_action 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running read-buildbot-config step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: read_buildbot_config 14:01:56 INFO - Using buildbot properties: 14:01:56 INFO - { 14:01:56 INFO - "properties": { 14:01:56 INFO - "buildnumber": 113, 14:01:56 INFO - "product": "firefox", 14:01:56 INFO - "script_repo_revision": "production", 14:01:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:01:56 INFO - "repository": "", 14:01:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:01:56 INFO - "buildid": "20151205122329", 14:01:56 INFO - "slavename": "talos-linux64-ix-032", 14:01:56 INFO - "pgo_build": "False", 14:01:56 INFO - "basedir": "/builds/slave/test", 14:01:56 INFO - "project": "", 14:01:56 INFO - "platform": "ubuntu64_hw", 14:01:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:01:56 INFO - "slavebuilddir": "test", 14:01:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:01:56 INFO - "branch": "mozilla-central", 14:01:56 INFO - "repo_path": "mozilla-central", 14:01:56 INFO - "stage_platform": "linux64", 14:01:56 INFO - "builduid": "1ca0b8ce67cb48548d4d133cec0f76e9", 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - }, 14:01:56 INFO - "sourcestamp": { 14:01:56 INFO - "repository": "", 14:01:56 INFO - "hasPatch": false, 14:01:56 INFO - "project": "", 14:01:56 INFO - "branch": "mozilla-central-linux64-talos", 14:01:56 INFO - "changes": [ 14:01:56 INFO - { 14:01:56 INFO - "category": null, 14:01:56 INFO - "files": [ 14:01:56 INFO - { 14:01:56 INFO - "url": null, 14:01:56 INFO - "name": "https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:01:56 INFO - } 14:01:56 INFO - ], 14:01:56 INFO - "repository": "", 14:01:56 INFO - "rev": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960", 14:01:56 INFO - "who": "ryanvm@gmail.com", 14:01:56 INFO - "when": 1449352906, 14:01:56 INFO - "number": 6802349, 14:01:56 INFO - "comments": "Merge b2g-inbound to m-c. a=merge", 14:01:56 INFO - "project": "", 14:01:56 INFO - "at": "Sat 05 Dec 2015 14:01:46", 14:01:56 INFO - "branch": "mozilla-central-linux64-talos", 14:01:56 INFO - "revlink": "", 14:01:56 INFO - "properties": [ 14:01:56 INFO - [ 14:01:56 INFO - "buildid", 14:01:56 INFO - "20151205122329", 14:01:56 INFO - "Change" 14:01:56 INFO - ], 14:01:56 INFO - [ 14:01:56 INFO - "builduid", 14:01:56 INFO - "1ca0b8ce67cb48548d4d133cec0f76e9", 14:01:56 INFO - "Change" 14:01:56 INFO - ], 14:01:56 INFO - [ 14:01:56 INFO - "pgo_build", 14:01:56 INFO - "False", 14:01:56 INFO - "Change" 14:01:56 INFO - ] 14:01:56 INFO - ], 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - } 14:01:56 INFO - ], 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - } 14:01:56 INFO - } 14:01:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:01:56 INFO - Running post-action listener: _resource_record_post_action 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running download-and-extract step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: download_and_extract 14:01:56 INFO - mkdir: /builds/slave/test/build/tests 14:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:56 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json 14:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json 14:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:01:57 INFO - Downloaded 1302 bytes. 14:01:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:01:57 INFO - Using the following test package requirements: 14:01:57 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'jsshell-linux-x86_64.zip'], 14:01:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:01:57 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:01:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01: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')]} 14:01:57 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:01:59 INFO - Downloaded 21848971 bytes. 14:01:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:01:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:01:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:02:00 INFO - Return code: 0 14:02:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02: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')]} 14:02:00 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:03 INFO - Downloaded 21848971 bytes. 14:02:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:02:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:02:05 INFO - Return code: 0 14:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:05 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:02:06 INFO - Downloaded 11132001 bytes. 14:02:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:02:07 INFO - Return code: 0 14:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:07 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:02:08 INFO - Downloaded 57708588 bytes. 14:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:08 INFO - mkdir: /builds/slave/test/properties 14:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:08 INFO - Contents: 14:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:08 INFO - Running post-action listener: _resource_record_post_action 14:02:08 INFO - Running post-action listener: set_extra_try_arguments 14:02:08 INFO - ##### 14:02:08 INFO - ##### Running populate-webroot step. 14:02:08 INFO - ##### 14:02:08 INFO - Running pre-action listener: _resource_record_pre_action 14:02:08 INFO - Running main action method: populate_webroot 14:02:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:02:08 INFO - '../fennec_ids.txt'], 14:02:08 INFO - 'tests': ['tcheck2']}, 14:02:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:08 INFO - '--tppagecycles', 14:02:08 INFO - '7'], 14:02:08 INFO - 'tests': ['tsvgm']}}, 14:02:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:02:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'tests': ['damp', 'tps']}, 14:02:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['damp', 'tps']}, 14:02:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:08 INFO - 'other': {'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'other_l64': {'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'other_nol64': {'tests': ['a11yr', 14:02:08 INFO - 'ts_paint', 14:02:08 INFO - 'tpaint', 14:02:08 INFO - 'sessionrestore', 14:02:08 INFO - 'sessionrestore_no_auto_restore']}, 14:02:08 INFO - 'svgr': {'tests': ['tsvgx', 14:02:08 INFO - 'tsvgr_opacity', 14:02:08 INFO - 'tart', 14:02:08 INFO - 'tscrollx', 14:02:08 INFO - 'cart']}, 14:02:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['tsvgx', 14:02:08 INFO - 'tsvgr_opacity', 14:02:08 INFO - 'tart', 14:02:08 INFO - 'tscrollx', 14:02:08 INFO - 'cart']}, 14:02:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'tests': ['tp5o']}, 14:02:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'talos_options': ['--e10s'], 14:02:08 INFO - 'tests': ['tp5o']}, 14:02:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'talos_options': ['--xperf_path', 14:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:08 INFO - 'tests': ['tp5n']}, 14:02:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:08 INFO - 'talos_options': ['--e10s', 14:02:08 INFO - '--xperf_path', 14:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:08 INFO - 'tests': ['tp5n']}}, 14:02:08 INFO - 'talos.zip': {'path': '', 14:02:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:08 INFO - Running post-action listener: _resource_record_post_action 14:02:08 INFO - ##### 14:02:08 INFO - ##### Running create-virtualenv step. 14:02:08 INFO - ##### 14:02:08 INFO - Running pre-action listener: _resource_record_pre_action 14:02:08 INFO - Running main action method: create_virtualenv 14:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:08 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 14:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:08 INFO - Using real prefix '/usr' 14:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:11 INFO - Installing pip.................done. 14:02:11 INFO - Return code: 0 14:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:11 INFO - Using env: {'DISPLAY': ':0', 14:02:11 INFO - 'HOME': '/home/cltbld', 14:02:11 INFO - 'LANG': 'en_US.UTF-8', 14:02:11 INFO - 'LANGUAGE': 'en_US:en', 14:02:11 INFO - 'LOGNAME': 'cltbld', 14:02:11 INFO - 'MAIL': '/var/mail/cltbld', 14:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:11 INFO - 'MOZ_NO_REMOTE': '1', 14:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:11 INFO - 'NO_EM_RESTART': '1', 14:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:11 INFO - 'PWD': '/builds/slave/test', 14:02:11 INFO - 'SHELL': '/bin/bash', 14:02:11 INFO - 'SHLVL': '1', 14:02:11 INFO - 'TERM': 'linux', 14:02:11 INFO - 'TMOUT': '86400', 14:02:11 INFO - 'USER': 'cltbld', 14:02:11 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:11 INFO - '_': '/tools/buildbot/bin/python'} 14:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:11 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 14:02:11 INFO - Cleaning up... 14:02:11 INFO - Return code: 0 14:02:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:11 INFO - Using env: {'DISPLAY': ':0', 14:02:11 INFO - 'HOME': '/home/cltbld', 14:02:11 INFO - 'LANG': 'en_US.UTF-8', 14:02:11 INFO - 'LANGUAGE': 'en_US:en', 14:02:11 INFO - 'LOGNAME': 'cltbld', 14:02:11 INFO - 'MAIL': '/var/mail/cltbld', 14:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:11 INFO - 'MOZ_NO_REMOTE': '1', 14:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:11 INFO - 'NO_EM_RESTART': '1', 14:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:11 INFO - 'PWD': '/builds/slave/test', 14:02:11 INFO - 'SHELL': '/bin/bash', 14:02:11 INFO - 'SHLVL': '1', 14:02:11 INFO - 'TERM': 'linux', 14:02:11 INFO - 'TMOUT': '86400', 14:02:11 INFO - 'USER': 'cltbld', 14:02:11 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:11 INFO - '_': '/tools/buildbot/bin/python'} 14:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:11 INFO - Downloading/unpacking psutil>=0.7.1 14:02:11 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 14:02:11 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 14:02:11 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 14:02:11 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 14:02:11 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 14:02:11 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 14:02:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:02:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:13 INFO - Installing collected packages: psutil 14:02:13 INFO - Running setup.py install for psutil 14:02:13 INFO - building 'psutil._psutil_linux' extension 14:02:13 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 14:02:13 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 14:02:13 INFO - building 'psutil._psutil_posix' extension 14:02:13 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 14:02:13 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 14:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:13 INFO - Successfully installed psutil 14:02:13 INFO - Cleaning up... 14:02:13 INFO - Return code: 0 14:02:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:02:13 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')]} 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 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')]} 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:13 INFO - Using env: {'DISPLAY': ':0', 14:02:13 INFO - 'HOME': '/home/cltbld', 14:02:13 INFO - 'LANG': 'en_US.UTF-8', 14:02:13 INFO - 'LANGUAGE': 'en_US:en', 14:02:13 INFO - 'LOGNAME': 'cltbld', 14:02:13 INFO - 'MAIL': '/var/mail/cltbld', 14:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:13 INFO - 'MOZ_NO_REMOTE': '1', 14:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:13 INFO - 'NO_EM_RESTART': '1', 14:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:13 INFO - 'PWD': '/builds/slave/test', 14:02:13 INFO - 'SHELL': '/bin/bash', 14:02:13 INFO - 'SHLVL': '1', 14:02:13 INFO - 'TERM': 'linux', 14:02:13 INFO - 'TMOUT': '86400', 14:02:13 INFO - 'USER': 'cltbld', 14:02:13 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:13 INFO - '_': '/tools/buildbot/bin/python'} 14:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:02:14 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 14:02:14 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 14:02:14 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 14:02:14 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 14:02:14 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 14:02:14 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 14:02:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:02:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:02:15 INFO - Installing collected packages: mozsystemmonitor 14:02:15 INFO - Running setup.py install for mozsystemmonitor 14:02:15 INFO - Successfully installed mozsystemmonitor 14:02:15 INFO - Cleaning up... 14:02:15 INFO - Return code: 0 14:02:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:16 INFO - Using env: {'DISPLAY': ':0', 14:02:16 INFO - 'HOME': '/home/cltbld', 14:02:16 INFO - 'LANG': 'en_US.UTF-8', 14:02:16 INFO - 'LANGUAGE': 'en_US:en', 14:02:16 INFO - 'LOGNAME': 'cltbld', 14:02:16 INFO - 'MAIL': '/var/mail/cltbld', 14:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:16 INFO - 'MOZ_NO_REMOTE': '1', 14:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:16 INFO - 'NO_EM_RESTART': '1', 14:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:16 INFO - 'PWD': '/builds/slave/test', 14:02:16 INFO - 'SHELL': '/bin/bash', 14:02:16 INFO - 'SHLVL': '1', 14:02:16 INFO - 'TERM': 'linux', 14:02:16 INFO - 'TMOUT': '86400', 14:02:16 INFO - 'USER': 'cltbld', 14:02:16 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:16 INFO - '_': '/tools/buildbot/bin/python'} 14:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:18 INFO - Downloading docopt-0.6.1.tar.gz 14:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:18 INFO - Running setup.py install for blobuploader 14:02:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:18 INFO - Running setup.py install for requests 14:02:19 INFO - Running setup.py install for docopt 14:02:19 INFO - Successfully installed blobuploader requests docopt 14:02:19 INFO - Cleaning up... 14:02:19 INFO - Return code: 0 14:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:19 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')]} 14:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 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')]} 14:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 14:02:19 INFO - Using env: {'DISPLAY': ':0', 14:02:19 INFO - 'HOME': '/home/cltbld', 14:02:19 INFO - 'LANG': 'en_US.UTF-8', 14:02:19 INFO - 'LANGUAGE': 'en_US:en', 14:02:19 INFO - 'LOGNAME': 'cltbld', 14:02:19 INFO - 'MAIL': '/var/mail/cltbld', 14:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:19 INFO - 'MOZ_NO_REMOTE': '1', 14:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:19 INFO - 'NO_EM_RESTART': '1', 14:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:19 INFO - 'PWD': '/builds/slave/test', 14:02:19 INFO - 'SHELL': '/bin/bash', 14:02:19 INFO - 'SHLVL': '1', 14:02:19 INFO - 'TERM': 'linux', 14:02:19 INFO - 'TMOUT': '86400', 14:02:19 INFO - 'USER': 'cltbld', 14:02:19 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:19 INFO - '_': '/tools/buildbot/bin/python'} 14:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:19 INFO - Running setup.py (path:/tmp/pip-6ky7Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Running setup.py (path:/tmp/pip-s6461q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:19 INFO - Running setup.py (path:/tmp/pip-Xzsq1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:19 INFO - Running setup.py (path:/tmp/pip-cuY0nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:19 INFO - Running setup.py (path:/tmp/pip-ZoMUbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:19 INFO - Running setup.py (path:/tmp/pip-qjte_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:19 INFO - Running setup.py (path:/tmp/pip-K4u6ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:20 INFO - Running setup.py (path:/tmp/pip-yaiHLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:20 INFO - Running setup.py (path:/tmp/pip-6HRXwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:20 INFO - Running setup.py (path:/tmp/pip-FWMBER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Running setup.py (path:/tmp/pip-V0ZDI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Running setup.py (path:/tmp/pip-He5OGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:20 INFO - Running setup.py (path:/tmp/pip-LtNqap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:20 INFO - Running setup.py (path:/tmp/pip-s0IblZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:20 INFO - Running setup.py (path:/tmp/pip-zCCy95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:20 INFO - Running setup.py (path:/tmp/pip-iWRmC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:20 INFO - Running setup.py (path:/tmp/pip-rnH74I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:20 INFO - Running setup.py install for manifestparser 14:02:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:20 INFO - Running setup.py install for mozcrash 14:02:20 INFO - Running setup.py install for mozdebug 14:02:21 INFO - Running setup.py install for mozdevice 14:02:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozfile 14:02:21 INFO - Running setup.py install for mozhttpd 14:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozinfo 14:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozInstall 14:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozleak 14:02:21 INFO - Running setup.py install for mozlog 14:02:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for moznetwork 14:02:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozprocess 14:02:21 INFO - Running setup.py install for mozprofile 14:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozrunner 14:02:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozscreenshot 14:02:22 INFO - Running setup.py install for moztest 14:02:22 INFO - Running setup.py install for mozversion 14:02:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:22 INFO - Cleaning up... 14:02:22 INFO - Return code: 0 14:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:22 INFO - Using env: {'DISPLAY': ':0', 14:02:22 INFO - 'HOME': '/home/cltbld', 14:02:22 INFO - 'LANG': 'en_US.UTF-8', 14:02:22 INFO - 'LANGUAGE': 'en_US:en', 14:02:22 INFO - 'LOGNAME': 'cltbld', 14:02:22 INFO - 'MAIL': '/var/mail/cltbld', 14:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:22 INFO - 'MOZ_NO_REMOTE': '1', 14:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:22 INFO - 'NO_EM_RESTART': '1', 14:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:22 INFO - 'PWD': '/builds/slave/test', 14:02:22 INFO - 'SHELL': '/bin/bash', 14:02:22 INFO - 'SHLVL': '1', 14:02:22 INFO - 'TERM': 'linux', 14:02:22 INFO - 'TMOUT': '86400', 14:02:22 INFO - 'USER': 'cltbld', 14:02:22 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:22 INFO - '_': '/tools/buildbot/bin/python'} 14:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:22 INFO - Running setup.py (path:/tmp/pip-ymvdxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:22 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)) 14:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:22 INFO - Running setup.py (path:/tmp/pip-GUsF_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:22 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)) 14:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:22 INFO - Running setup.py (path:/tmp/pip-7rSp4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:22 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)) 14:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:22 INFO - Running setup.py (path:/tmp/pip-Sbxg3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:23 INFO - Running setup.py (path:/tmp/pip-OOwCjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:23 INFO - Running setup.py (path:/tmp/pip-STbkgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:23 INFO - Running setup.py (path:/tmp/pip-JeRQZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:23 INFO - Running setup.py (path:/tmp/pip-UB3iXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:23 INFO - Running setup.py (path:/tmp/pip-wX4re7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:23 INFO - Running setup.py (path:/tmp/pip-T0EBmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:23 INFO - Running setup.py (path:/tmp/pip-v6Kr3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:23 INFO - Running setup.py (path:/tmp/pip-fxVvRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:23 INFO - Running setup.py (path:/tmp/pip-0egbxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:23 INFO - Running setup.py (path:/tmp/pip-jmbPBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:23 INFO - Running setup.py (path:/tmp/pip-mMSCCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:23 INFO - Running setup.py (path:/tmp/pip-hSufHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:23 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)) 14:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:23 INFO - Running setup.py (path:/tmp/pip-c1MKAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:23 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)) 14:02:23 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)) 14:02:23 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)) 14:02:23 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)) 14:02:23 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:23 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:24 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 14:02:24 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 14:02:24 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 14:02:24 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 14:02:24 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 14:02:24 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 14:02:25 INFO - Downloading blessings-1.5.1.tar.gz 14:02:25 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:25 INFO - Installing collected packages: blessings 14:02:25 INFO - Running setup.py install for blessings 14:02:25 INFO - Successfully installed blessings 14:02:25 INFO - Cleaning up... 14:02:25 INFO - Return code: 0 14:02:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:26 INFO - Reading from file tmpfile_stdout 14:02:26 INFO - Current package versions: 14:02:26 INFO - argparse == 1.2.1 14:02:26 INFO - blessings == 1.5.1 14:02:26 INFO - blobuploader == 1.2.4 14:02:26 INFO - docopt == 0.6.1 14:02:26 INFO - manifestparser == 1.1 14:02:26 INFO - mozInstall == 1.12 14:02:26 INFO - mozcrash == 0.16 14:02:26 INFO - mozdebug == 0.1 14:02:26 INFO - mozdevice == 0.47 14:02:26 INFO - mozfile == 1.2 14:02:26 INFO - mozhttpd == 0.7 14:02:26 INFO - mozinfo == 0.9 14:02:26 INFO - mozleak == 0.1 14:02:26 INFO - mozlog == 3.1 14:02:26 INFO - moznetwork == 0.27 14:02:26 INFO - mozprocess == 0.22 14:02:26 INFO - mozprofile == 0.27 14:02:26 INFO - mozrunner == 6.11 14:02:26 INFO - mozscreenshot == 0.1 14:02:26 INFO - mozsystemmonitor == 0.0 14:02:26 INFO - moztest == 0.7 14:02:26 INFO - mozversion == 1.4 14:02:26 INFO - psutil == 3.1.1 14:02:26 INFO - requests == 1.2.3 14:02:26 INFO - wsgiref == 0.1.2 14:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:26 INFO - Using env: {'DISPLAY': ':0', 14:02:26 INFO - 'HOME': '/home/cltbld', 14:02:26 INFO - 'LANG': 'en_US.UTF-8', 14:02:26 INFO - 'LANGUAGE': 'en_US:en', 14:02:26 INFO - 'LOGNAME': 'cltbld', 14:02:26 INFO - 'MAIL': '/var/mail/cltbld', 14:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:26 INFO - 'MOZ_NO_REMOTE': '1', 14:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:26 INFO - 'NO_EM_RESTART': '1', 14:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:26 INFO - 'PWD': '/builds/slave/test', 14:02:26 INFO - 'SHELL': '/bin/bash', 14:02:26 INFO - 'SHLVL': '1', 14:02:26 INFO - 'TERM': 'linux', 14:02:26 INFO - 'TMOUT': '86400', 14:02:26 INFO - 'USER': 'cltbld', 14:02:26 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:26 INFO - '_': '/tools/buildbot/bin/python'} 14:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:26 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 1)) 14:02:26 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 2)) 14:02:26 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 3)) 14:02:26 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 4)) 14:02:26 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 5)) 14:02:26 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 6)) 14:02:26 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 7)) 14:02:26 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 8)) 14:02:26 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:26 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 3)) 14:02:26 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:26 INFO - Cleaning up... 14:02:26 INFO - Return code: 0 14:02:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:26 INFO - Using env: {'DISPLAY': ':0', 14:02:26 INFO - 'HOME': '/home/cltbld', 14:02:26 INFO - 'LANG': 'en_US.UTF-8', 14:02:26 INFO - 'LANGUAGE': 'en_US:en', 14:02:26 INFO - 'LOGNAME': 'cltbld', 14:02:26 INFO - 'MAIL': '/var/mail/cltbld', 14:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:26 INFO - 'MOZ_NO_REMOTE': '1', 14:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:26 INFO - 'NO_EM_RESTART': '1', 14:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:26 INFO - 'PWD': '/builds/slave/test', 14:02:26 INFO - 'SHELL': '/bin/bash', 14:02:26 INFO - 'SHLVL': '1', 14:02:26 INFO - 'TERM': 'linux', 14:02:26 INFO - 'TMOUT': '86400', 14:02:26 INFO - 'USER': 'cltbld', 14:02:26 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:26 INFO - '_': '/tools/buildbot/bin/python'} 14:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:26 INFO - Downloading/unpacking jsonschema 14:02:26 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 14:02:26 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 14:02:26 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 14:02:26 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 14:02:26 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 14:02:26 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 14:02:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:02:28 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:28 INFO - warning: no files found matching '*.txt' 14:02:28 INFO - no previously-included directories found matching 'build' 14:02:28 INFO - no previously-included directories found matching 'dist' 14:02:28 INFO - no previously-included directories found matching '.git*' 14:02:28 INFO - Installing collected packages: jsonschema, functools32 14:02:28 INFO - Running setup.py install for functools32 14:02:28 INFO - warning: no files found matching '*.txt' 14:02:28 INFO - no previously-included directories found matching 'build' 14:02:28 INFO - no previously-included directories found matching 'dist' 14:02:28 INFO - no previously-included directories found matching '.git*' 14:02:28 INFO - Successfully installed jsonschema functools32 14:02:28 INFO - Cleaning up... 14:02:28 INFO - Return code: 0 14:02:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02:28 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')]} 14:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:28 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')]} 14:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fdb68cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', '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 14:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:02:28 INFO - Using env: {'DISPLAY': ':0', 14:02:28 INFO - 'HOME': '/home/cltbld', 14:02:28 INFO - 'LANG': 'en_US.UTF-8', 14:02:28 INFO - 'LANGUAGE': 'en_US:en', 14:02:28 INFO - 'LOGNAME': 'cltbld', 14:02:28 INFO - 'MAIL': '/var/mail/cltbld', 14:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:28 INFO - 'MOZ_NO_REMOTE': '1', 14:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:28 INFO - 'NO_EM_RESTART': '1', 14:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:28 INFO - 'PWD': '/builds/slave/test', 14:02:28 INFO - 'SHELL': '/bin/bash', 14:02:28 INFO - 'SHLVL': '1', 14:02:28 INFO - 'TERM': 'linux', 14:02:28 INFO - 'TMOUT': '86400', 14:02:28 INFO - 'USER': 'cltbld', 14:02:28 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:28 INFO - '_': '/tools/buildbot/bin/python'} 14:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:28 INFO - Downloading/unpacking flake8 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:28 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 14:02:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:02:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:02:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:02:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:31 INFO - no previously-included directories found matching 'docs/_build' 14:02:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:31 INFO - Running setup.py install for pep8 14:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:31 INFO - no previously-included directories found matching 'docs/_build' 14:02:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:31 INFO - Cleaning up... 14:02:31 INFO - Return code: 0 14:02:31 INFO - Running post-action listener: _resource_record_post_action 14:02:31 INFO - Running post-action listener: _start_resource_monitoring 14:02:31 INFO - Starting resource monitoring. 14:02:31 INFO - ##### 14:02:31 INFO - ##### Running install step. 14:02:31 INFO - ##### 14:02:31 INFO - Running pre-action listener: _resource_record_pre_action 14:02:31 INFO - Running main action method: install 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Output received: 14:02:31 INFO - Usage: mozinstall [options] installer 14:02:31 INFO - Options: 14:02:31 INFO - -h, --help show this help message and exit 14:02:31 INFO - -d DEST, --destination=DEST 14:02:31 INFO - Directory to install application into. [default: 14:02:31 INFO - "/builds/slave/test"] 14:02:31 INFO - --app=APP Application being installed. [default: firefox] 14:02:31 INFO - mkdir: /builds/slave/test/build/application 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:02:48 INFO - Reading from file tmpfile_stdout 14:02:48 INFO - Output received: 14:02:48 INFO - /builds/slave/test/build/application/firefox/firefox 14:02:48 INFO - Running post-action listener: _resource_record_post_action 14:02:48 INFO - ##### 14:02:48 INFO - ##### Running run-tests step. 14:02:48 INFO - ##### 14:02:48 INFO - Running pre-action listener: _resource_record_pre_action 14:02:48 INFO - Running main action method: run_tests 14:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:02:48 INFO - Python 2.7.3 14:02:48 INFO - Return code: 0 14:02:48 INFO - grabbing minidump binary from tooltool 14:02: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')]} 14:02:48 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 0x1cf90b0>, '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 0x1cf9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:02:48 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 14:02:48 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 14:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:48 INFO - Return code: 0 14:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:02:49 INFO - Return code: 0 14:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test/build 14:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 14:02:49 INFO - Using env: {'DISPLAY': ':0', 14:02:49 INFO - 'HOME': '/home/cltbld', 14:02:49 INFO - 'LANG': 'en_US.UTF-8', 14:02:49 INFO - 'LANGUAGE': 'en_US:en', 14:02:49 INFO - 'LOGNAME': 'cltbld', 14:02:49 INFO - 'MAIL': '/var/mail/cltbld', 14:02:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:02:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:49 INFO - 'MOZ_NO_REMOTE': '1', 14:02:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:49 INFO - 'NO_EM_RESTART': '1', 14:02:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:49 INFO - 'PWD': '/builds/slave/test', 14:02:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:02:49 INFO - 'SHELL': '/bin/bash', 14:02:49 INFO - 'SHLVL': '1', 14:02:49 INFO - 'TERM': 'linux', 14:02:49 INFO - 'TMOUT': '86400', 14:02:49 INFO - 'USER': 'cltbld', 14:02:49 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024', 14:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:49 INFO - '_': '/tools/buildbot/bin/python'} 14:02:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 14:02:49 INFO - mozversion INFO | application_buildid: 20151205122329 14:02:49 INFO - mozversion INFO | application_changeset: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 14:02:49 INFO - mozversion INFO | application_display_name: Nightly 14:02:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:49 INFO - mozversion INFO | application_name: Firefox 14:02:49 INFO - mozversion INFO | application_remotingname: firefox 14:02:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 14:02:49 INFO - mozversion INFO | application_vendor: Mozilla 14:02:49 INFO - mozversion INFO | application_version: 45.0a1 14:02:49 INFO - mozversion INFO | platform_buildid: 20151205122329 14:02:49 INFO - mozversion INFO | platform_changeset: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 14:02:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 14:02:49 INFO - mozversion INFO | platform_version: 45.0a1 14:02:49 INFO - 2015-12-05 14:02:49,409 DEBUG : using testdate: 1449352969 14:02:49 INFO - 2015-12-05 14:02:49,410 DEBUG : actual date: 1449352969 14:02:49 INFO - 2015-12-05 14:02:49,457 INFO : starting webserver on 'localhost:52351' 14:02:49 INFO - 2015-12-05 14:02:49,458 INFO : Starting test suite talos-linux64-ix-032.e 14:02:49 INFO - 2015-12-05 14:02:49,458 INFO : Starting test dromaeo_css 14:02:49 INFO - 2015-12-05 14:02:49,458 DEBUG : operating with platform_type : linux_ 14:02:49 INFO - 2015-12-05 14:02:49,459 INFO : Initialising browser for dromaeo_css test... 14:02:49 INFO - 2015-12-05 14:02:49,474 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOfUQy/profile http://localhost:52351/getInfo.html 14:02:55 INFO - 2015-12-05 14:02:55,519 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:02:55 INFO - 2015-12-05 14:02:55,519 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:02:55 INFO - 2015-12-05 14:02:55,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:02:55 INFO - 2015-12-05 14:02:55,520 DEBUG : BROWSER_OUTPUT: __metrics 14:02:55 INFO - 2015-12-05 14:02:55,697 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:02:56 INFO - 2015-12-05 14:02:56,705 INFO : Browser initialized. 14:02:56 INFO - 2015-12-05 14:02:56,706 INFO : Running cycle 1/1 for dromaeo_css test... 14:02:56 INFO - 2015-12-05 14:02:56,706 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuOfUQy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:08 INFO - 2015-12-05 14:03:08,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 143761408 14:03:08 INFO - 2015-12-05 14:03:08,789 DEBUG : BROWSER_OUTPUT: 14:03:58 INFO - 2015-12-05 14:03:58,428 DEBUG : BROWSER_OUTPUT: 1449353038427 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] 14:06:10 INFO - 2015-12-05 14:06:10,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52351/tests/dromaeo/cssquery-ext.html) 14:06:12 INFO - 2015-12-05 14:06:12,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 147656704 14:06:12 INFO - 2015-12-05 14:06:12,037 DEBUG : BROWSER_OUTPUT: 14:09:14 INFO - 2015-12-05 14:09:14,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-ext.html (next: http://localhost:52351/tests/dromaeo/cssquery-jquery.html) 14:09:14 INFO - 2015-12-05 14:09:14,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 145563648 14:09:14 INFO - 2015-12-05 14:09:14,629 DEBUG : BROWSER_OUTPUT: 14:12:16 INFO - 2015-12-05 14:12:16,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52351/tests/dromaeo/cssquery-mootools.html) 14:12:17 INFO - 2015-12-05 14:12:17,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 145281024 14:12:17 INFO - 2015-12-05 14:12:17,081 DEBUG : BROWSER_OUTPUT: 14:15:18 INFO - 2015-12-05 14:15:18,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52351/tests/dromaeo/cssquery-prototype.html) 14:15:19 INFO - 2015-12-05 14:15:19,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 144728064 14:15:19 INFO - 2015-12-05 14:15:19,439 DEBUG : BROWSER_OUTPUT: 14:18:21 INFO - 2015-12-05 14:18:21,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52351/tests/dromaeo/cssquery-yui.html) 14:18:22 INFO - 2015-12-05 14:18:22,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 145993728 14:18:22 INFO - 2015-12-05 14:18:22,557 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/dromaeo/cssquery-yui.html (next: http://localhost:52351/tests/dromaeo/cssquery-dojo.html) 14:21:25 INFO - 2015-12-05 14:21:25,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 147644416 14:21:25 INFO - 2015-12-05 14:21:25,329 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,330 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:21:25 INFO - 2015-12-05 14:21:25,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:21:25 INFO - 2015-12-05 14:21:25,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:21:25 INFO - 2015-12-05 14:21:25,330 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:21:25 INFO - 2015-12-05 14:21:25,332 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2633.433811730478;2695.5956606509035;2707.864606769661;2718.9728102718977;2734.890604375824;4460.420145381096;4697.788599513022;4715.292706094087;4727.598154156893;4767.690100143493;4558.726476411418;4647.512011238822;4680.4149481314835;4691.530846915307;4744.5492678195515;4269.252880745873;4280.914381712356;4310.224159651261;4317.352397140438;4339.370791235269;4306;4349.26062569364;4377.430933978579;4406.052698669785;4414.845480408187;4128.545859955402;4216.388623649585;4233.280342341809;4302.397664326997;4356.934645980313;4259.680523960716;4287.549807270223;4295.334223195378;4296.484421869364;4310.418093557361;4280.422143010716;4323.6757243206885;4328.329108988112;4334.9783251083545;4354.433923589945;4416.646668266531;4439.156560253541;4470.75410852403;4644.303354496818;4694.929576056362;4967.975160124212;5023.120953833101;5046.990601879602;5047.4447810740785;5048.3941926969;4788.592969597588;5038.773255203525;5060.974695126538;5088.618353623456;5112.41207261166;4539.477960034572;4614.400127983341;4676.3453116563705;4697.365855609449;4748.857534273978;5176.637635365563;5202.2456743771945;5203.60972927032;5221.765020574007;5246.580273578181;4734.21885388907;4812.06164797868;5002.424721157041;5003.824866129741;5018.197088465828;4913.1893237615395;4958;4964.702117872939;4997.350344455198;5016.598672106223;5000.149974504343;5018.799248030038;5028.396592408862;5028.673136246132;5076.238564215398;4721.693089949143;4812.374391329175;4991.725455099931;5008.574271186917;5051.318072060225;4084.1627466369323;4121.196366708523;4135.60711732385;4169.4162817205615;4175.123224122968;3641.0715267606593;3657.8536858525363;3661.176235347079;3681.208540163878;3690;4113.321301985199;4224.471941007374;4228.577142285747;4290.914181716411;4328.874492631875;5035.748212589356;5040.31955685985;5041.067402530543;5041.873953151201;5063.164577844688;4312.482502099768;4322.589354011364;4327.199468098349;4331.112122014979;4336.956630433655;4218.156368726267;4322.200392927256;4420.80106395213;4424.469063712375;4535;4745.406824146981;4754.643401744883;4754.809807607795;4756.833510827105;4767.785449654704;5009.273655320031;5009.674371165863;5021.347224860745;5027.27104569828;5032.3961124665275;4564.863054108382;4645.953540464688;4665.650076244227;4671.672982891165;4682;4987.226979818134;4993.325901003318;5012.799488020439;5020.347354843993;5025.321581586439;5055.848324550269;5059.038782631288;5100.311457953278;5105.693658380509;5130.204818253177;4683.555062269079;4805.639577031667;4860.489648586848;4911.361523001987;5005.824796132118;4853.174960256835;4855.223164293696;4856.538628830255;4865.440474345354;4897.167481528078;4725.432948046257;4761.785719642694;4770.236762118045;4772.594329482033;4778.235482322812;4686.27362758773;4762.190427627243;4786.473487916396;4851.46633870281;4894.583960363267;4772.976135119302;4805.471398146131;4820.325154478306;4822.565969062801;4827.758612069312 14:21:25 INFO - 2015-12-05 14:21:25,333 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.872609299861;565.2058857305486;569.1207085053597;580.9194897490667;581.3343721438952;34133.1466713332;34368.656313436855;34472.48291275626;34505.82747086264;34530.30939381211;39717;40349.19301613966;40432;40485;40551.39172912409;8003.159668234839;8142.307903828152;8148.062972758149;8155.918440815575;8170.468919520212;7901.20987901211;7967.880481792778;8054.879176812353;8063;8065.112837587861;7894.64474098667;8011.879821802678;8015;8028.799280018017;8070.878936815952;7924.643391047417;8026.7591972240925;8033.919660803404;8060.193980601952;8061.274485296322;7908.130105688369;8035.598220088972;8078.272955434039;8101.513909165469;8106.432549721522;37906;38016;38076.23847523062;38220.80889595562;38432.80783596092;2605.739426057398;2681.048227879094;3008.413359394897;3207.4671192193514;3263.4452143135723;27267.181984540497;27447;27541;27543.724562754516;27663.44673106547;3388.6611338865914;3444.4488881778793;3490.075130090528;3508;3573.5175751273505;221200;225050;225289;225797;226771.99999999834;52804.47195528072;54258.18612720812;57355.71322143362;57754.42245577575;57768.422315776304;66572.66713666401;67836.6608166956;68214;68301.65849170822;68404.31595684079;14756.409743610135;15002.774958375632;15015.174165421007;15025.699486010219;15088.924555377153;10166;10332.948335258276;10355;10365.481725913674;10367;19520.609587808165;19546.70679939802;19712.507187320432;19739.901300493693;19746;7728.961355193188;7814.648340824677;7913.44605877583;7936.761897143095;7969.481983671043;836.3225787112458;863.5121156546531;875.7722992021993;879.969201077972;980.1717548671361;25063.373415664755;25552.38418394832;25633.487330253665;25738.35654108662;25763;975.3611384543135;975.5853762151057;982.0523195116747;988.9159421449258;1097.8517900083546;15883.126428046337;15895.284712187979;16150.757738633694;16264.674706505804;16511.256993435323;341795;344553;346366;346760;347217;48880.26679599809;49130.50869491331;49217;49218;49230.261546076836;1238.96283111505;1240.7828629989715;1241.596481143632;1246.426643743888;1364.8976326775532;28009.439811203254;28021.299467513476;28233.15300540987;28246.293842654097;28594.285142871595;40212;40701;40738;40819;40973;256620;257192;259204;259763;259928;29390.53047347667;41833.79083104565;43253.783731081145;43521.56478435175;43683.78158109189;46093.76953115213;46411;46562.661063314634;46822;47584.286235707186;34547.82726086354;34747.13132171716;34872.82563587166;35524.46713299251;35680.464793027604;34470.31059378848;35018.824905875306;35106.29787404289;35248.823755882084;35313.64686353104;35046.82476587601;36378.636213637525;36512.634873650924;36780;36925.446118308784;28697.426051478436;31469.370612588078;31564;31606.525902111025;31745.365092698477;24101.276961691176;24391.878040609685;24555.017799288544;24579.877100615096;24862.627060593742 14:21:25 INFO - 2015-12-05 14:21:25,333 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.1984369623005;327.3306285832597;335.8153015841287;336.6885630791517;337.1117106424571;12520.373981300922;12962.092653514257;14865.25673716314;15198.316075776589;16532.66934661306;15053.096814191129;15226.39094436224;15774.053556786572;15875.206239688026;15908.125053122103;4975.950240497603;5010.498950104997;5092.108880945838;5095.668781529207;5095.872603184913;4985.576226020793;5095.159298715726;5105.2086926526445;5152.433232344439;5167.715775632339;5041.773120209599;5056.823011194609;5105.030044291572;5427.592930530206;6044.637321760686;6016.27804663441;6073.483753880925;6076.149339092531;6076.301225359052;6090.66501342426;5231.163013917793;5320.840374788762;5323.201519772027;5339.6262261641705;5346.893062138735;11375.715607109805;11581.826272605918;11587.710307242301;13281.601551953458;19037.619247615108;1596.9201539923074;1734.1242672450458;1742.1550547984218;1794.291254954299;1811.2392795026121;8416.074231834493;8427.07302196764;8526;8678.86981695275;8782.824343513093;1622.9026258424415;1624.9512514624462;1649.9752503712455;1700.0564686598932;1722.2938595176042;53502.394928152215;55342;56123;56171.43828561703;57267.427325726625;9843.606255749834;9953.701388958343;10010.699679009642;10031.949840250752;10037.749056273506;12443.564475243504;12493.625191244277;12504.31226282545;12508.061895357885;12524.123311368117;7122.715091396286;7124.323189297009;7129.857402851914;7181.605011724405;7190.496665233488;6970;7047.43620510358;7270.745523906638;7333.449991250677;7344.963275183697;4073.9592604074173;4180.163967206571;4240.321548552217;4254.106637606075;4273.9358909616385;1760.4982579964649;1808.6111486030566;1817.591042015536;1834.5321942904475;1838.9908050459662;813.7558732380262;904.2991681446931;907.9273658107336;930.4882314727008;966.6906589891308;15311;15346;15687.68624627501;15789.368425262861;16104.516864494084;818.6193420059701;825.4180802534199;832.1719888710651;877.8463768840427;931.5109567477128;8932.732018039469;8951.194392504705;8990.775230619156;9154.954225228832;9346.672866449777;513989;516464;518199.0109829767;532403;538128;70959.64520177366;71818.2818171822;73163.26836731564;73167.63416182886;74435;1081.3998230981724;1091.3233795046963;1119.7144728094283;1122.180808010157;1127.4193790198055;13644.249566273951;13975.930120349332;14181.787273191117;14320.06919550226;14504.129752214902;21752.564948701252;23626.52746945086;29524.704752952195;29576.556351655174;30824;39711;40717.59282407256;41434.1713165741;42030.579694202665;42333.153336933705;8743.737687869374;8874.64501419936;8878.378513503993;9072.637094516145;9080.273578113867;12371.938140309601;12933.094683372074;15010.399584016517;15397.84602153964;15581.610459738597;13029.481785377484;13034.152780069266;13221.074524783173;13292.601221963356;13470.663233419244;12929.482820687443;13014.544490942772;13163.53927612529;13346.399412026289;13495;12846.229226246454;13169.209847408803;13351.132176408502;13397.799033014708;13537.458501659823;9027.23268522183;9049.366544341832;9060.864087038568;9099.044600317136;9197.172254497127;12895.742085158432;12972.675683107998;13140.934295328845;13148.276844773629;13772.931135344259 14:21:25 INFO - 2015-12-05 14:21:25,337 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.143167678585;1679.9916000419998;1755.3768412213665;1772.8936263824164;1774.7958984716756;6206.379362063792;6355.777547785829;6896.4827637927165;7152.570845749258;7223.674934627941;7241.131064272295;7388.113426388841;7397.371223446014;7402.925970740291;7453.888191677115;2059.2792522617037;2092.319996001298;2098.0244186453297;2098.9055492502875;2099.6640537514;2036.8065033821838;2100.2439121916173;2102.1906565972135;2106.515501434671;2116.2381542644634;2029.736134302546;2054.496648321156;2062.9071691773906;2081.885496297703;2082.729245198122;2075.4811297175706;2089.9477513062143;2095.1200495791804;2096.95806083879;2105.905234264462;2041.2141325589607;2072.512959454527;2074.6265672179;2075.740532433446;2080.0431801371387;6935.375816176518;6947.201071876749;7053.788386348418;7065.92934070663;7088.078549788546;4202.516710578261;4281.422008028907;4281.678874084456;4282.143571285756;4320.740755554677;2668.7731542818883;2690.515707172708;2714.9185524434297;2728.6589176352954;2747.2719729271757;838.9035260945009;859.1408591408591;867.2931560777946;884.7168905950099;884.8938127424686;9897.15874150698;9924.95037524815;9956.651517196935;9963.750906227402;9986.400815950994;3908.804559772;3921.6470517653547;3925.3130702127014;3938.4879965604287;3953.940690889639;8616.095309992486;8631.6978905738;8638.352123590756;8642.3950323478;8648.09195034525;4309.762963037;4356.411884395629;4392.626626736763;4397.8240870364825;4425.203463376623;3280.3603297356785;3347.7656564040285;3857.3056849767313;3977.1449138434796;3977.880663580097;3431.571053618298;3514.806685632315;3545.4150065239464;3548.8935331940083;3564.6435356464144;1133.2237417369129;1151.4933429291252;1154.682462322851;1160;1167.270455965022;1181.9940900295614;1191.6722901202238;1202.7774861650623;1227.9201851879777;1241.9689507762378;6961.338672826073;7009.264027277164;7050.5769653820935;7056.188538318159;7067.257937916547;401.33979603551995;401.76697515440975;402.7784718404866;407.694229328004;409.56586018820144;5395.838124856261;5454.263674403984;5457.836264912059;5459.044667183227;5473.75368108436;8714.128587141362;8790.560471976376;8882.777930551658;8949.373543851998;8986.370954033286;8801.647934082564;8831.249343805848;8850.20348168668;8892.244159246537;8904.910950890539;6653.767118150841;6902.482313826483;6993.090898183305;7002.284440312156;7015.263397343308;6536.575122617015;6568.113304703995;6577.671116444254;6579.934200657932;6597.670116494252;7184.784456466315;7308.123025237006;7375.11498620169;7491.325780679765;7498;7413.888791668237;7557.584332861746;7565.848683026419;7601.695932162873;7619.314261716472;5525.392206857162;5784.566157538117;6146.631202127886;6385.393387628168;6439.452646525097;7031.578105313698;7054.329838665319;7059.5058345915295;7074.327938845801;7090.113735783028;6480.57876238043;6576.572522786004;6583.901241481286;6609.735610575715;6802.285759995129;6312.116303717391;6376;6384.425401713868;6410.262819775599;6446.4520515756685;6220.129181914626;6266.843328916813;6282.623042617275;6286.4342209201395;6291.02489114188;5828;5848.385919478394;5913.822585322448;5937.139114828412;5957.285125784933;5909.113632954919;5961.672108033927;5973.701314934149;6000.0999850022845;6005.849853753516 14:21:25 INFO - 2015-12-05 14:21:25,337 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.62513668842035;277.4741864167403;282.87836230420925;284.3899834854238;287.5471132965579;5251.658642188255;5390.056740070482;5492.588055895809;5554.611177217591;5583.106702927533;5441.5102640762425;5493.368262649797;5534.501894829465;5535.972320138394;5539.335279766434;4237.4279472271155;4239.025024244418;4239.3852891330735;4241.597048280424;4246.214450326684;4224.873253802375;4240.27915254406;4241.130568233505;4248.511421186557;4255.4467919170465;4182.2681030819485;4185.8534951276715;4198.0344520760245;4202.579742025789;4206.263903816835;4088.4480595119576;4192.308269135589;4196.076863090146;4201;4211.957880421187;3607.9098022549383;3610.332088563624;3637.0907273181706;3640.4357324614725;3649.361361761681;5031.698098114125;5201.739913004372;5319.521243088102;5331.546818520431;5345.1714984177515;4688.460827004904;4790.880227994328;4816.879578010543;4820.63845211607;4828.661993660445;5713.314402271712;5741.081426971707;5751.396103409165;5754.6547207167705;5757.82726518201;3944.5266568011734;3949.624785645359;3953.9011524711823;3956.920861582781;3958.129211573478;5886.941130588725;6026.156338112624;6037.396260373971;6056.121862329937;6060.939390606126;4051.777152256654;4055.8377664893665;4067.5525692173837;4067.7559346439307;4075.2664520386024;4138.151678905817;4145.502539695256;4147.896302592399;4148.128892932457;4153.480814898137;4772.809087636525;4777.904441911142;4784.808607655725;4787.16224660683;4788.353572267769;5656.660600363992;5763.596548241583;5767.423257674283;5771.88456230873;5780.826575202751;1431.6921861799556;1460.0801495058045;1460.1020372471066;1463.2829913342598;1463.8097047383985;968.5157421289356;969.9951500242454;970.8203982263304;994.4033579852031;994.7015895231547;4973.8010479581135;4982.825601104017;4985.277134815431;4990.675606085593;4997.350344455198;5887.470127688529;5943.821685349447;5945.910811337833;5958.6722730249385;5967.910481342783;4997.100521906019;5002.274670172877;5003.124453220672;5006.199008158677;5011.874703132378;3132.451820931328;3192.74458043356;3224.822634755111;3231.1760501072076;3232.1273256221157;5610.410906854803;5634.549236061105;5635.69003704792;5638.35158956717;5646.887062258732;6009.128676341993;6098;6126.417990291005;6215.06773983897;6227.937720622826;5655.151727240865;5659.066254068115;5665.461781130786;5672.4894759471845;5706.144078388275;5969.641821490724;5985.910211346921;6009.969950150221;6016.518678505621;6018.458338749533;5778.711064446845;5885.882282354414;5887.293524777054;5894.557908156991;5897.498712609305;5657.4059723728415;5682.801101961411;5690.402507736628;5692.943070569241;5693.174489698888;3957.406389041667;3995.760254384746;4008.1983603278877;4008.4388185654616;4011.939820902747;6011.6994150293185;6035.78874739382;6037.184980027816;6045.093236014633;6060.272767267779;5685.175649530712;5812.070068789142;5812.128180772918;5814.5639077068545;5825.0679891217205;5805.82582522525;5812.244408226903;5812.680302583399;5820.417958204146;5820.70896455184;5683;5688.488036076773;5690.2887139107615;5699.8860022800145;5704.914426283692;5647.407022262768;5802.723400851806;5831.979403604437;5841.065429531254;5876.1773351729935;5676.943230567642;5681.346645135697;5689.2319536862;5720.11338242573;5727.713614319351 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.86103848711;709.8904471715771;761.2805898425986;767.9709189685822;794.1343935110729;10454.059134677878;10627.787444251111;10655;10726.624568140116;10736.516856741455;10960.451977401139;11068.557257709703;11109.833352499698;11110.833337499944;11112.333260004405;632.3486808587139;636.6912047656883;796.2157275084038;797.2227078598378;814.7515007922581;818.0469752738082;819.6803246733749;826.099551488877;827.0571548434789;828.2380210206625;854.2994744309668;856.8072183758667;858.8797568340406;859.1923591823665;862.8964524257098;847.9448835825651;848.3171047306915;850.1540966738104;852.5609311204704;852.9701460448855;633.5976654824174;634.0299342006691;635.4408120853666;635.5392340553108;635.7361694896613;11126.109911207164;11198.888011119867;11238.213325067249;11261.324320540794;11264.887351126466;9786.41281523111;9940.25448091396;11093.445327733662;11957.461914213882;12363.320017399039;9347;9513.429194248367;9580.329376943617;9733.756656083584;9786.90213097867;3264.9020529384156;3282.1302354875975;3291.4240007998505;3296.8186749728757;3299.5215693724276;41332.79333603313;42096;42199.7890010548;42496.57503424988;42633;9396.436213827192;9432.90567094334;9488.905110948941;9545.47499887499;9617.374870633386;16287.59281017984;16414.589635259214;16447.09540975234;16534.586635334213;16555.420560280334;6245.718942647592;6292.653904035322;6362.968185159045;6366.236051673736;6439.259485159267;3397.8980630581123;3420.196253880336;3440.913977150541;3447.3450044491465;3517.876874309438;2570.0619273964867;2585.379508917884;2602.700689420703;2602.7527384898403;2616.136674897279;471.08374212157025;472.95270472953115;476.49253544974493;478.88746144655977;481.53772378517016;511.8771494841211;512.0680361741595;574.7327492715907;597.9162917191596;602.9487493563096;7179.210286868441;7218.314260145383;7246.058012458347;7356.926430735732;7386.74146404884;485.6794515619674;500.40451862283766;513.599392473871;538.3835508342926;564.8533477041613;3596.6942809861457;3597.568291805;3673.366111163487;3715.535558055243;3768;48897.75551122222;49007.50992490101;50264.24603630875;50346;50775;40226.79886600548;40559;40765.592344076176;40778.38832417516;41028.79485602613;40341.79829100836;41307.7934610325;41344.793276032826;41370;41494.37758433626;7509.51188172767;7714.961425192838;7824.6870125194355;8022.478538894953;8053.516788992679;30234.395312094075;30716.69283307138;30813.537796933513;30894.53658195174;31323.216919577193;41159.1768164641;41320.586794131676;41330.586694132675;41649.79175104105;41970.58029419789;10194;10274.537645805807;10319.793604128026;10473.423961682181;10966.890331096905;11444.94277528607;11521.135914806591;11538.653840384803;11583.247088939192;11615.419229038345;10737.570497180337;10787.6224332148;10816.891831081588;10967.945160274467;11457.770844583229;10167.745806354604;10730.678079657622;11094;11407.885921140682;11446.313221206754;10711.732206694895;10877;11151.665450036511;11485.48315325829;11491.770164596493;9322.580483878377;9451.858222126812;9487.335886488156;9534.97888989796;9625.470599117116;8676.522791246542;8716.956415217883;9275;9375.671851485438;9541.713748587554 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354085329__endTimestamp 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:21:25 INFO - 2015-12-05 14:21:25,341 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,342 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4613.61 Median:4744.55 stddev:488.77 (10.3%) stddev-sans-first:464.93 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: Values: 2633.4 2695.6 2707.9 2719.0 2734.9 4460.4 4697.8 4715.3 4727.6 4767.7 4558.7 4647.5 4680.4 4691.5 4744.5 4269.3 4280.9 4310.2 4317.4 4339.4 4306.0 4349.3 4377.4 4406.1 4414.8 4128.5 4216.4 4233.3 4302.4 4356.9 4259.7 4287.5 4295.3 4296.5 4310.4 4280.4 4323.7 4328.3 4335.0 4354.4 4416.6 4439.2 4470.8 4644.3 4694.9 4968.0 5023.1 5047.0 5047.4 5048.4 4788.6 5038.8 5061.0 5088.6 5112.4 4539.5 4614.4 4676.3 4697.4 4748.9 5176.6 5202.2 5203.6 5221.8 5246.6 4734.2 4812.1 5002.4 5003.8 5018.2 4913.2 4958.0 4964.7 4997.4 5016.6 5000.1 5018.8 5028.4 5028.7 5076.2 4721.7 4812.4 4991.7 5008.6 5051.3 4084.2 4121.2 4135.6 4169.4 4175.1 3641.1 3657.9 3661.2 3681.2 3690.0 4113.3 4224.5 4228.6 4290.9 4328.9 5035.7 5040.3 5041.1 5041.9 5063.2 4312.5 4322.6 4327.2 4331.1 4337.0 4218.2 4322.2 4420.8 4424.5 4535.0 4745.4 4754.6 4754.8 4756.8 4767.8 5009.3 5009.7 5021.3 5027.3 5032.4 4564.9 4646.0 4665.7 4671.7 4682.0 4987.2 4993.3 5012.8 5020.3 5025.3 5055.8 5059.0 5100.3 5105.7 5130.2 4683.6 4805.6 4860.5 4911.4 5005.8 4853.2 4855.2 4856.5 4865.4 4897.2 4725.4 4761.8 4770.2 4772.6 4778.2 4686.3 4762.2 4786.5 4851.5 4894.6 4773.0 4805.5 4820.3 4822.6 4827.8 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44577.57 Median:35602.47 stddev:73607.81 (206.7%) stddev-sans-first:73740.08 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: Values: 553.9 565.2 569.1 580.9 581.3 34133.1 34368.7 34472.5 34505.8 34530.3 39717.0 40349.2 40432.0 40485.0 40551.4 8003.2 8142.3 8148.1 8155.9 8170.5 7901.2 7967.9 8054.9 8063.0 8065.1 7894.6 8011.9 8015.0 8028.8 8070.9 7924.6 8026.8 8033.9 8060.2 8061.3 7908.1 8035.6 8078.3 8101.5 8106.4 37906.0 38016.0 38076.2 38220.8 38432.8 2605.7 2681.0 3008.4 3207.5 3263.4 27267.2 27447.0 27541.0 27543.7 27663.4 3388.7 3444.4 3490.1 3508.0 3573.5 221200.0 225050.0 225289.0 225797.0 226772.0 52804.5 54258.2 57355.7 57754.4 57768.4 66572.7 67836.7 68214.0 68301.7 68404.3 14756.4 15002.8 15015.2 15025.7 15088.9 10166.0 10332.9 10355.0 10365.5 10367.0 19520.6 19546.7 19712.5 19739.9 19746.0 7729.0 7814.6 7913.4 7936.8 7969.5 836.3 863.5 875.8 880.0 980.2 25063.4 25552.4 25633.5 25738.4 25763.0 975.4 975.6 982.1 988.9 1097.9 15883.1 15895.3 16150.8 16264.7 16511.3 341795.0 344553.0 346366.0 346760.0 347217.0 48880.3 49130.5 49217.0 49218.0 49230.3 1239.0 1240.8 1241.6 1246.4 1364.9 28009.4 28021.3 28233.2 28246.3 28594.3 40212.0 40701.0 40738.0 40819.0 40973.0 256620.0 257192.0 259204.0 259763.0 259928.0 29390.5 41833.8 43253.8 43521.6 43683.8 46093.8 46411.0 46562.7 46822.0 47584.3 34547.8 34747.1 34872.8 35524.5 35680.5 34470.3 35018.8 35106.3 35248.8 35313.6 35046.8 36378.6 36512.6 36780.0 36925.4 28697.4 31469.4 31564.0 31606.5 31745.4 24101.3 24391.9 24555.0 24579.9 24862.6 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27020.13 Median:22754.07 stddev:85530.03 (375.9%) stddev-sans-first:85746.46 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: Values: 316.2 327.3 335.8 336.7 337.1 12520.4 12962.1 14865.3 15198.3 16532.7 15053.1 15226.4 15774.1 15875.2 15908.1 4976.0 5010.5 5092.1 5095.7 5095.9 4985.6 5095.2 5105.2 5152.4 5167.7 5041.8 5056.8 5105.0 5427.6 6044.6 6016.3 6073.5 6076.1 6076.3 6090.7 5231.2 5320.8 5323.2 5339.6 5346.9 11375.7 11581.8 11587.7 13281.6 19037.6 1596.9 1734.1 1742.2 1794.3 1811.2 8416.1 8427.1 8526.0 8678.9 8782.8 1622.9 1625.0 1650.0 1700.1 1722.3 53502.4 55342.0 56123.0 56171.4 57267.4 9843.6 9953.7 10010.7 10031.9 10037.7 12443.6 12493.6 12504.3 12508.1 12524.1 7122.7 7124.3 7129.9 7181.6 7190.5 6970.0 7047.4 7270.7 7333.4 7345.0 4074.0 4180.2 4240.3 4254.1 4273.9 1760.5 1808.6 1817.6 1834.5 1839.0 813.8 904.3 907.9 930.5 966.7 15311.0 15346.0 15687.7 15789.4 16104.5 818.6 825.4 832.2 877.8 931.5 8932.7 8951.2 8990.8 9155.0 9346.7 513989.0 516464.0 518199.0 532403.0 538128.0 70959.6 71818.3 73163.3 73167.6 74435.0 1081.4 1091.3 1119.7 1122.2 1127.4 13644.2 13975.9 14181.8 14320.1 14504.1 21752.6 23626.5 29524.7 29576.6 30824.0 39711.0 40717.6 41434.2 42030.6 42333.2 8743.7 8874.6 8878.4 9072.6 9080.3 12371.9 12933.1 15010.4 15397.8 15581.6 13029.5 13034.2 13221.1 13292.6 13470.7 12929.5 13014.5 13163.5 13346.4 13495.0 12846.2 13169.2 13351.1 13397.8 13537.5 9027.2 9049.4 9060.9 9099.0 9197.2 12895.7 12972.7 13140.9 13148.3 13772.9 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5023.16 Median:6002.97 stddev:2635.83 (43.9%) stddev-sans-first:2629.85 14:21:25 INFO - 2015-12-05 14:21:25,343 DEBUG : BROWSER_OUTPUT: Values: 1490.1 1680.0 1755.4 1772.9 1774.8 6206.4 6355.8 6896.5 7152.6 7223.7 7241.1 7388.1 7397.4 7402.9 7453.9 2059.3 2092.3 2098.0 2098.9 2099.7 2036.8 2100.2 2102.2 2106.5 2116.2 2029.7 2054.5 2062.9 2081.9 2082.7 2075.5 2089.9 2095.1 2097.0 2105.9 2041.2 2072.5 2074.6 2075.7 2080.0 6935.4 6947.2 7053.8 7065.9 7088.1 4202.5 4281.4 4281.7 4282.1 4320.7 2668.8 2690.5 2714.9 2728.7 2747.3 838.9 859.1 867.3 884.7 884.9 9897.2 9925.0 9956.7 9963.8 9986.4 3908.8 3921.6 3925.3 3938.5 3953.9 8616.1 8631.7 8638.4 8642.4 8648.1 4309.8 4356.4 4392.6 4397.8 4425.2 3280.4 3347.8 3857.3 3977.1 3977.9 3431.6 3514.8 3545.4 3548.9 3564.6 1133.2 1151.5 1154.7 1160.0 1167.3 1182.0 1191.7 1202.8 1227.9 1242.0 6961.3 7009.3 7050.6 7056.2 7067.3 401.3 401.8 402.8 407.7 409.6 5395.8 5454.3 5457.8 5459.0 5473.8 8714.1 8790.6 8882.8 8949.4 8986.4 8801.6 8831.2 8850.2 8892.2 8904.9 6653.8 6902.5 6993.1 7002.3 7015.3 6536.6 6568.1 6577.7 6579.9 6597.7 7184.8 7308.1 7375.1 7491.3 7498.0 7413.9 7557.6 7565.8 7601.7 7619.3 5525.4 5784.6 6146.6 6385.4 6439.5 7031.6 7054.3 7059.5 7074.3 7090.1 6480.6 6576.6 6583.9 6609.7 6802.3 6312.1 6376.0 6384.4 6410.3 6446.5 6220.1 6266.8 6282.6 6286.4 6291.0 5828.0 5848.4 5913.8 5937.1 5957.3 5909.1 5961.7 5973.7 6000.1 6005.8 14:21:25 INFO - 2015-12-05 14:21:25,344 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,344 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4766.86 Median:5535.24 stddev:1421.81 (25.7%) stddev-sans-first:1385.24 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: Values: 274.6 277.5 282.9 284.4 287.5 5251.7 5390.1 5492.6 5554.6 5583.1 5441.5 5493.4 5534.5 5536.0 5539.3 4237.4 4239.0 4239.4 4241.6 4246.2 4224.9 4240.3 4241.1 4248.5 4255.4 4182.3 4185.9 4198.0 4202.6 4206.3 4088.4 4192.3 4196.1 4201.0 4212.0 3607.9 3610.3 3637.1 3640.4 3649.4 5031.7 5201.7 5319.5 5331.5 5345.2 4688.5 4790.9 4816.9 4820.6 4828.7 5713.3 5741.1 5751.4 5754.7 5757.8 3944.5 3949.6 3953.9 3956.9 3958.1 5886.9 6026.2 6037.4 6056.1 6060.9 4051.8 4055.8 4067.6 4067.8 4075.3 4138.2 4145.5 4147.9 4148.1 4153.5 4772.8 4777.9 4784.8 4787.2 4788.4 5656.7 5763.6 5767.4 5771.9 5780.8 1431.7 1460.1 1460.1 1463.3 1463.8 968.5 970.0 970.8 994.4 994.7 4973.8 4982.8 4985.3 4990.7 4997.4 5887.5 5943.8 5945.9 5958.7 5967.9 4997.1 5002.3 5003.1 5006.2 5011.9 3132.5 3192.7 3224.8 3231.2 3232.1 5610.4 5634.5 5635.7 5638.4 5646.9 6009.1 6098.0 6126.4 6215.1 6227.9 5655.2 5659.1 5665.5 5672.5 5706.1 5969.6 5985.9 6010.0 6016.5 6018.5 5778.7 5885.9 5887.3 5894.6 5897.5 5657.4 5682.8 5690.4 5692.9 5693.2 3957.4 3995.8 4008.2 4008.4 4011.9 6011.7 6035.8 6037.2 6045.1 6060.3 5685.2 5812.1 5812.1 5814.6 5825.1 5805.8 5812.2 5812.7 5820.4 5820.7 5683.0 5688.5 5690.3 5699.9 5704.9 5647.4 5802.7 5832.0 5841.1 5876.2 5676.9 5681.3 5689.2 5720.1 5727.7 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12220.23 Median:42348.18 stddev:13808.37 (32.6%) stddev-sans-first:13819.90 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: Values: 677.9 709.9 761.3 768.0 794.1 10454.1 10627.8 10655.0 10726.6 10736.5 10960.5 11068.6 11109.8 11110.8 11112.3 632.3 636.7 796.2 797.2 814.8 818.0 819.7 826.1 827.1 828.2 854.3 856.8 858.9 859.2 862.9 847.9 848.3 850.2 852.6 853.0 633.6 634.0 635.4 635.5 635.7 11126.1 11198.9 11238.2 11261.3 11264.9 9786.4 9940.3 11093.4 11957.5 12363.3 9347.0 9513.4 9580.3 9733.8 9786.9 3264.9 3282.1 3291.4 3296.8 3299.5 41332.8 42096.0 42199.8 42496.6 42633.0 9396.4 9432.9 9488.9 9545.5 9617.4 16287.6 16414.6 16447.1 16534.6 16555.4 6245.7 6292.7 6363.0 6366.2 6439.3 3397.9 3420.2 3440.9 3447.3 3517.9 2570.1 2585.4 2602.7 2602.8 2616.1 471.1 473.0 476.5 478.9 481.5 511.9 512.1 574.7 597.9 602.9 7179.2 7218.3 7246.1 7356.9 7386.7 485.7 500.4 513.6 538.4 564.9 3596.7 3597.6 3673.4 3715.5 3768.0 48897.8 49007.5 50264.2 50346.0 50775.0 40226.8 40559.0 40765.6 40778.4 41028.8 40341.8 41307.8 41344.8 41370.0 41494.4 7509.5 7715.0 7824.7 8022.5 8053.5 30234.4 30716.7 30813.5 30894.5 31323.2 41159.2 41320.6 41330.6 41649.8 41970.6 10194.0 10274.5 10319.8 10473.4 10966.9 11444.9 11521.1 11538.7 11583.2 11615.4 10737.6 10787.6 10816.9 10967.9 11457.8 10167.7 10730.7 11094.0 11407.9 11446.3 10711.7 10877.0 11151.7 11485.5 11491.8 9322.6 9451.9 9487.3 9535.0 9625.5 8676.5 8717.0 9275.0 9375.7 9541.7 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:21:25 INFO - 2015-12-05 14:21:25,345 DEBUG : BROWSER_OUTPUT: 14:21:26 INFO - 2015-12-05 14:21:26,141 INFO : Browser exited with error code: 0 14:21:26 INFO - 2015-12-05 14:21:26,163 INFO : Completed test dromaeo_css (00:18:36) 14:21:26 INFO - 2015-12-05 14:21:26,163 INFO : Starting test kraken 14:21:26 INFO - 2015-12-05 14:21:26,163 DEBUG : operating with platform_type : linux_ 14:21:26 INFO - 2015-12-05 14:21:26,163 INFO : Initialising browser for kraken test... 14:21:26 INFO - 2015-12-05 14:21:26,169 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0wErQ/profile http://localhost:52351/getInfo.html 14:21:31 INFO - 2015-12-05 14:21:31,940 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:21:31 INFO - 2015-12-05 14:21:31,940 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:21:31 INFO - 2015-12-05 14:21:31,940 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:21:31 INFO - 2015-12-05 14:21:31,940 DEBUG : BROWSER_OUTPUT: __metrics 14:21:32 INFO - 2015-12-05 14:21:32,098 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:21:33 INFO - 2015-12-05 14:21:33,077 INFO : Browser initialized. 14:21:33 INFO - 2015-12-05 14:21:33,078 INFO : Running cycle 1/1 for kraken test... 14:21:33 INFO - 2015-12-05 14:21:33,078 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0wErQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:21:45 INFO - 2015-12-05 14:21:45,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 143060992 14:21:45 INFO - 2015-12-05 14:21:45,109 DEBUG : BROWSER_OUTPUT: 14:21:47 INFO - 2015-12-05 14:21:47,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52351/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:48 INFO - 2015-12-05 14:21:48,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 143876096 14:21:48 INFO - 2015-12-05 14:21:48,328 DEBUG : BROWSER_OUTPUT: 14:21:51 INFO - 2015-12-05 14:21:51,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52351/tests/kraken/driver.html?testName=audio-dft) 14:21:51 INFO - 2015-12-05 14:21:51,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 144297984 14:21:51 INFO - 2015-12-05 14:21:51,720 DEBUG : BROWSER_OUTPUT: 14:21:54 INFO - 2015-12-05 14:21:54,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52351/tests/kraken/driver.html?testName=audio-fft) 14:21:55 INFO - 2015-12-05 14:21:55,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 14:21:55 INFO - 2015-12-05 14:21:55,203 DEBUG : BROWSER_OUTPUT: 14:21:57 INFO - 2015-12-05 14:21:57,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52351/tests/kraken/driver.html?testName=audio-oscillator) 14:21:57 INFO - 2015-12-05 14:21:57,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 14:21:57 INFO - 2015-12-05 14:21:57,922 DEBUG : BROWSER_OUTPUT: 14:22:00 INFO - 2015-12-05 14:22:00,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:00 INFO - 2015-12-05 14:22:00,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 140308480 14:22:00 INFO - 2015-12-05 14:22:00,777 DEBUG : BROWSER_OUTPUT: 14:22:03 INFO - 2015-12-05 14:22:03,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52351/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:04 INFO - 2015-12-05 14:22:04,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 139456512 14:22:04 INFO - 2015-12-05 14:22:04,430 DEBUG : BROWSER_OUTPUT: 14:22:07 INFO - 2015-12-05 14:22:07,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52351/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:08 INFO - 2015-12-05 14:22:08,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 14:22:08 INFO - 2015-12-05 14:22:08,587 DEBUG : BROWSER_OUTPUT: 14:22:11 INFO - 2015-12-05 14:22:11,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52351/tests/kraken/driver.html?testName=json-parse-financial) 14:22:12 INFO - 2015-12-05 14:22:12,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 137863168 14:22:12 INFO - 2015-12-05 14:22:12,078 DEBUG : BROWSER_OUTPUT: 14:22:13 INFO - 2015-12-05 14:22:13,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:14 INFO - 2015-12-05 14:22:14,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 140066816 14:22:14 INFO - 2015-12-05 14:22:14,421 DEBUG : BROWSER_OUTPUT: 14:22:16 INFO - 2015-12-05 14:22:16,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:16 INFO - 2015-12-05 14:22:16,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 140980224 14:22:16 INFO - 2015-12-05 14:22:16,900 DEBUG : BROWSER_OUTPUT: 14:22:19 INFO - 2015-12-05 14:22:19,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:19 INFO - 2015-12-05 14:22:19,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 140931072 14:22:19 INFO - 2015-12-05 14:22:19,667 DEBUG : BROWSER_OUTPUT: 14:22:22 INFO - 2015-12-05 14:22:22,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:22 INFO - 2015-12-05 14:22:22,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 14:22:22 INFO - 2015-12-05 14:22:22,858 DEBUG : BROWSER_OUTPUT: 14:22:25 INFO - 2015-12-05 14:22:25,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:26 INFO - 2015-12-05 14:22:26,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 140779520 14:22:26 INFO - 2015-12-05 14:22:26,062 DEBUG : BROWSER_OUTPUT: 14:22:27 INFO - 2015-12-05 14:22:27,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52351/tests/kraken/driver.html?testName=ai-astar) 14:22:28 INFO - 2015-12-05 14:22:28,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 141172736 14:22:28 INFO - 2015-12-05 14:22:28,067 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,068 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:22:28 INFO - 2015-12-05 14:22:28,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:22:28 INFO - 2015-12-05 14:22:28,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:22:28 INFO - 2015-12-05 14:22:28,069 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:22:28 INFO - 2015-12-05 14:22:28,069 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;113;112;112;124;113;111;111;112 14:22:28 INFO - 2015-12-05 14:22:28,069 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;134;156;164;129;169;169;138;168;131 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;162;165;175;162;163;164;161 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;72;73;73;72;148;76;71;72 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;135;93;95;94;133;95;95;133 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;112;110;111;111;110 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;149;149;148;147;148;148;147 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;97;96;96;96;96;96;95 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;72;72;73;73;76;72;71 14:22:28 INFO - 2015-12-05 14:22:28,070 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;69;68;68;68;68;68 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;106;84;85;86;86;86;83;91;85 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;121;123;123;134;125;122;135;131;132 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;143;146;144;148;146;157;162;144;144 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;68;71;73;71;68;69;69;70 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:22:28 INFO - 2015-12-05 14:22:28,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 14:22:28 INFO - 2015-12-05 14:22:28,072 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:22:28 INFO - 2015-12-05 14:22:28,072 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354148067__endTimestamp 14:22:28 INFO - 2015-12-05 14:22:28,072 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,079 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:22:28 INFO - 2015-12-05 14:22:28,079 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:22:28 INFO - 2015-12-05 14:22:28,079 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.32 (3.9%) stddev-sans-first:4.58 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 113.0 112.0 112.0 124.0 113.0 111.0 111.0 112.0 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.60 Median:161.00 stddev:16.73 (10.4%) stddev-sans-first:17.58 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: Values: 158.0 134.0 156.0 164.0 129.0 169.0 169.0 138.0 168.0 131.0 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:4.07 (2.5%) stddev-sans-first:4.30 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 162.0 165.0 175.0 162.0 163.0 164.0 161.0 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:72.50 stddev:23.80 (32.8%) stddev-sans-first:25.05 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 72.0 73.0 73.0 72.0 148.0 76.0 71.0 72.0 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.50 stddev:18.91 (20.0%) stddev-sans-first:19.53 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 135.0 93.0 95.0 94.0 133.0 95.0 95.0 133.0 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,080 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 112.0 110.0 111.0 111.0 110.0 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 149.0 149.0 148.0 147.0 148.0 148.0 147.0 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:73.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 72.0 73.0 73.0 76.0 72.0 71.0 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,081 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:85.50 stddev:6.88 (8.1%) stddev-sans-first:7.11 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: Values: 83.0 106.0 84.0 85.0 86.0 86.0 86.0 83.0 91.0 85.0 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:131.50 stddev:5.57 (4.2%) stddev-sans-first:5.59 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: Values: 133.0 121.0 123.0 123.0 134.0 125.0 122.0 135.0 131.0 132.0 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:146.00 stddev:8.13 (5.6%) stddev-sans-first:6.69 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: Values: 132.0 143.0 146.0 144.0 148.0 146.0 157.0 162.0 144.0 144.0 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.65 (2.4%) stddev-sans-first:1.73 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 71.0 73.0 71.0 68.0 69.0 69.0 70.0 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:22:28 INFO - 2015-12-05 14:22:28,082 DEBUG : BROWSER_OUTPUT: 14:22:29 INFO - 2015-12-05 14:22:29,053 INFO : Browser exited with error code: 0 14:22:29 INFO - 2015-12-05 14:22:29,102 INFO : Completed test kraken (00:01:02) 14:22:29 INFO - 2015-12-05 14:22:29,103 INFO : Starting test v8_7 14:22:29 INFO - 2015-12-05 14:22:29,103 DEBUG : operating with platform_type : linux_ 14:22:29 INFO - 2015-12-05 14:22:29,103 INFO : Initialising browser for v8_7 test... 14:22:29 INFO - 2015-12-05 14:22:29,109 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHwpfGT/profile http://localhost:52351/getInfo.html 14:22:35 INFO - 2015-12-05 14:22:35,042 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:22:35 INFO - 2015-12-05 14:22:35,042 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:22:35 INFO - 2015-12-05 14:22:35,042 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:22:35 INFO - 2015-12-05 14:22:35,042 DEBUG : BROWSER_OUTPUT: __metrics 14:22:35 INFO - 2015-12-05 14:22:35,461 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:36 INFO - 2015-12-05 14:22:36,429 INFO : Browser initialized. 14:22:36 INFO - 2015-12-05 14:22:36,430 INFO : Running cycle 1/1 for v8_7 test... 14:22:36 INFO - 2015-12-05 14:22:36,430 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHwpfGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:22:48 INFO - 2015-12-05 14:22:48,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 143433728 14:22:48 INFO - 2015-12-05 14:22:48,450 DEBUG : BROWSER_OUTPUT: 14:23:09 INFO - 2015-12-05 14:23:09,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52351/tests/v8_7/run.html (next: http://localhost:52351/tests/v8_7/run.html) 14:23:10 INFO - 2015-12-05 14:23:10,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 138649600 14:23:10 INFO - 2015-12-05 14:23:10,174 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,175 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:23:10 INFO - 2015-12-05 14:23:10,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |0;Richards;164.77179106936893 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.21729571271527 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.1618625277162 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1069.51871657754 14:23:10 INFO - 2015-12-05 14:23:10,176 DEBUG : BROWSER_OUTPUT: |5;Earley;714.2857142857143 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: |8;Splay;587.5440658049354 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:23:10 INFO - 2015-12-05 14:23:10,177 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354190174__endTimestamp 14:23:10 INFO - 2015-12-05 14:23:10,178 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:23:10 INFO - 2015-12-05 14:23:10,178 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:23:10 INFO - 2015-12-05 14:23:10,178 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,179 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.77 Median:164.77 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: Values: 164.8 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.22 Median:183.22 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: Values: 183.2 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.16 Median:277.16 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,180 DEBUG : BROWSER_OUTPUT: Values: 277.2 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: Values: 5218.8 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: Values: 1069.5 14:23:10 INFO - 2015-12-05 14:23:10,181 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: Values: 714.3 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: Values: 12195.1 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,182 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: Values: 25575.0 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:587.54 Median:587.54 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: Values: 587.5 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,183 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,184 DEBUG : BROWSER_OUTPUT: Values: 4845.4 14:23:10 INFO - 2015-12-05 14:23:10,184 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:23:10 INFO - 2015-12-05 14:23:10,184 DEBUG : BROWSER_OUTPUT: 14:23:11 INFO - 2015-12-05 14:23:11,129 INFO : Browser exited with error code: 0 14:23:11 INFO - 2015-12-05 14:23:11,146 INFO : Completed test v8_7 (00:00:42) 14:23:11 INFO - 2015-12-05 14:23:11,188 INFO : Completed test suite (00:20:21) 14:23:11 INFO - 2015-12-05 14:23:11,189 DEBUG : Working with test: dromaeo_css 14:23:11 INFO - 2015-12-05 14:23:11,189 DEBUG : Generating results file: dromaeo_css 14:23:11 INFO - 2015-12-05 14:23:11,190 DEBUG : Working with test: kraken 14:23:11 INFO - 2015-12-05 14:23:11,190 DEBUG : Generating results file: kraken 14:23:11 INFO - 2015-12-05 14:23:11,190 INFO : javascript benchmark 14:23:11 INFO - 2015-12-05 14:23:11,190 DEBUG : Working with test: v8_7 14:23:11 INFO - 2015-12-05 14:23:11,191 DEBUG : Generating results file: v8_7 14:23:11 INFO - 2015-12-05 14:23:11,191 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,263 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 14:23:11 INFO - 2015-12-05 14:23:11,264 DEBUG : process_Request line: dromaeo_css 6357.43 graph.html#tests=[[72,94,43]] 14:23:11 INFO - 2015-12-05 14:23:11,264 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,295 DEBUG : process_Request line: kraken 1541.40 graph.html#tests=[[232,94,43]] 14:23:11 INFO - 2015-12-05 14:23:11,295 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,327 DEBUG : process_Request line: v8_7 21494.14 graph.html#tests=[[230,94,43]] 14:23:11 INFO - 2015-12-05 14:23:11,328 INFO : javascript benchmark 14:23:11 INFO - 2015-12-05 14:23:11,332 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.433811730478, 2695.5956606509035, 2707.864606769661, 2718.9728102718977, 2734.890604375824, 4460.420145381096, 4697.788599513022, 4715.292706094087, 4727.598154156893, 4767.690100143493, 4558.726476411418, 4647.512011238822, 4680.4149481314835, 4691.530846915307, 4744.5492678195515, 4269.252880745873, 4280.914381712356, 4310.224159651261, 4317.352397140438, 4339.370791235269, 4306.0, 4349.26062569364, 4377.430933978579, 4406.052698669785, 4414.845480408187, 4128.545859955402, 4216.388623649585, 4233.280342341809, 4302.397664326997, 4356.934645980313, 4259.680523960716, 4287.549807270223, 4295.334223195378, 4296.484421869364, 4310.418093557361, 4280.422143010716, 4323.6757243206885, 4328.329108988112, 4334.9783251083545, 4354.433923589945, 4416.646668266531, 4439.156560253541, 4470.75410852403, 4644.303354496818, 4694.929576056362, 4967.975160124212, 5023.120953833101, 5046.990601879602, 5047.4447810740785, 5048.3941926969, 4788.592969597588, 5038.773255203525, 5060.974695126538, 5088.618353623456, 5112.41207261166, 4539.477960034572, 4614.400127983341, 4676.3453116563705, 4697.365855609449, 4748.857534273978, 5176.637635365563, 5202.2456743771945, 5203.60972927032, 5221.765020574007, 5246.580273578181, 4734.21885388907, 4812.06164797868, 5002.424721157041, 5003.824866129741, 5018.197088465828, 4913.1893237615395, 4958.0, 4964.702117872939, 4997.350344455198, 5016.598672106223, 5000.149974504343, 5018.799248030038, 5028.396592408862, 5028.673136246132, 5076.238564215398, 4721.693089949143, 4812.374391329175, 4991.725455099931, 5008.574271186917, 5051.318072060225, 4084.1627466369323, 4121.196366708523, 4135.60711732385, 4169.4162817205615, 4175.123224122968, 3641.0715267606593, 3657.8536858525363, 3661.176235347079, 3681.208540163878, 3690.0, 4113.321301985199, 4224.471941007374, 4228.577142285747, 4290.914181716411, 4328.874492631875, 5035.748212589356, 5040.31955685985, 5041.067402530543, 5041.873953151201, 5063.164577844688, 4312.482502099768, 4322.589354011364, 4327.199468098349, 4331.112122014979, 4336.956630433655, 4218.156368726267, 4322.200392927256, 4420.80106395213, 4424.469063712375, 4535.0, 4745.406824146981, 4754.643401744883, 4754.809807607795, 4756.833510827105, 4767.785449654704, 5009.273655320031, 5009.674371165863, 5021.347224860745, 5027.27104569828, 5032.3961124665275, 4564.863054108382, 4645.953540464688, 4665.650076244227, 4671.672982891165, 4682.0, 4987.226979818134, 4993.325901003318, 5012.799488020439, 5020.347354843993, 5025.321581586439, 5055.848324550269, 5059.038782631288, 5100.311457953278, 5105.693658380509, 5130.204818253177, 4683.555062269079, 4805.639577031667, 4860.489648586848, 4911.361523001987, 5005.824796132118, 4853.174960256835, 4855.223164293696, 4856.538628830255, 4865.440474345354, 4897.167481528078, 4725.432948046257, 4761.785719642694, 4770.236762118045, 4772.594329482033, 4778.235482322812, 4686.27362758773, 4762.190427627243, 4786.473487916396, 4851.46633870281, 4894.583960363267, 4772.976135119302, 4805.471398146131, 4820.325154478306, 4822.565969062801, 4827.758612069312], "unit": "ms", "name": "dojo.html", "value": 4583.24642113239}, {"lowerIsBetter": false, "replicates": [553.872609299861, 565.2058857305486, 569.1207085053597, 580.9194897490667, 581.3343721438952, 34133.1466713332, 34368.656313436855, 34472.48291275626, 34505.82747086264, 34530.30939381211, 39717.0, 40349.19301613966, 40432.0, 40485.0, 40551.39172912409, 8003.159668234839, 8142.307903828152, 8148.062972758149, 8155.918440815575, 8170.468919520212, 7901.20987901211, 7967.880481792778, 8054.879176812353, 8063.0, 8065.112837587861, 7894.64474098667, 8011.879821802678, 8015.0, 8028.799280018017, 8070.878936815952, 7924.643391047417, 8026.7591972240925, 8033.919660803404, 8060.193980601952, 8061.274485296322, 7908.130105688369, 8035.598220088972, 8078.272955434039, 8101.513909165469, 8106.432549721522, 37906.0, 38016.0, 38076.23847523062, 38220.80889595562, 38432.80783596092, 2605.739426057398, 2681.048227879094, 3008.413359394897, 3207.4671192193514, 3263.4452143135723, 27267.181984540497, 27447.0, 27541.0, 27543.724562754516, 27663.44673106547, 3388.6611338865914, 3444.4488881778793, 3490.075130090528, 3508.0, 3573.5175751273505, 221200.0, 225050.0, 225289.0, 225797.0, 226771.99999999834, 52804.47195528072, 54258.18612720812, 57355.71322143362, 57754.42245577575, 57768.422315776304, 66572.66713666401, 67836.6608166956, 68214.0, 68301.65849170822, 68404.31595684079, 14756.409743610135, 15002.774958375632, 15015.174165421007, 15025.699486010219, 15088.924555377153, 10166.0, 10332.948335258276, 10355.0, 10365.481725913674, 10367.0, 19520.609587808165, 19546.70679939802, 19712.507187320432, 19739.901300493693, 19746.0, 7728.961355193188, 7814.648340824677, 7913.44605877583, 7936.761897143095, 7969.481983671043, 836.3225787112458, 863.5121156546531, 875.7722992021993, 879.969201077972, 980.1717548671361, 25063.373415664755, 25552.38418394832, 25633.487330253665, 25738.35654108662, 25763.0, 975.3611384543135, 975.5853762151057, 982.0523195116747, 988.9159421449258, 1097.8517900083546, 15883.126428046337, 15895.284712187979, 16150.757738633694, 16264.674706505804, 16511.256993435323, 341795.0, 344553.0, 346366.0, 346760.0, 347217.0, 48880.26679599809, 49130.50869491331, 49217.0, 49218.0, 49230.261546076836, 1238.96283111505, 1240.7828629989715, 1241.596481143632, 1246.426643743888, 1364.8976326775532, 28009.439811203254, 28021.299467513476, 28233.15300540987, 28246.293842654097, 28594.285142871595, 40212.0, 40701.0, 40738.0, 40819.0, 40973.0, 256620.0, 257192.0, 259204.0, 259763.0, 259928.0, 29390.53047347667, 41833.79083104565, 43253.783731081145, 43521.56478435175, 43683.78158109189, 46093.76953115213, 46411.0, 46562.661063314634, 46822.0, 47584.286235707186, 34547.82726086354, 34747.13132171716, 34872.82563587166, 35524.46713299251, 35680.464793027604, 34470.31059378848, 35018.824905875306, 35106.29787404289, 35248.823755882084, 35313.64686353104, 35046.82476587601, 36378.636213637525, 36512.634873650924, 36780.0, 36925.446118308784, 28697.426051478436, 31469.370612588078, 31564.0, 31606.525902111025, 31745.365092698477, 24101.276961691176, 24391.878040609685, 24555.017799288544, 24579.877100615096, 24862.627060593742], "unit": "ms", "name": "ext.html", "value": 17719.711443959626}, {"lowerIsBetter": false, "replicates": [316.1984369623005, 327.3306285832597, 335.8153015841287, 336.6885630791517, 337.1117106424571, 12520.373981300922, 12962.092653514257, 14865.25673716314, 15198.316075776589, 16532.66934661306, 15053.096814191129, 15226.39094436224, 15774.053556786572, 15875.206239688026, 15908.125053122103, 4975.950240497603, 5010.498950104997, 5092.108880945838, 5095.668781529207, 5095.872603184913, 4985.576226020793, 5095.159298715726, 5105.2086926526445, 5152.433232344439, 5167.715775632339, 5041.773120209599, 5056.823011194609, 5105.030044291572, 5427.592930530206, 6044.637321760686, 6016.27804663441, 6073.483753880925, 6076.149339092531, 6076.301225359052, 6090.66501342426, 5231.163013917793, 5320.840374788762, 5323.201519772027, 5339.6262261641705, 5346.893062138735, 11375.715607109805, 11581.826272605918, 11587.710307242301, 13281.601551953458, 19037.619247615108, 1596.9201539923074, 1734.1242672450458, 1742.1550547984218, 1794.291254954299, 1811.2392795026121, 8416.074231834493, 8427.07302196764, 8526.0, 8678.86981695275, 8782.824343513093, 1622.9026258424415, 1624.9512514624462, 1649.9752503712455, 1700.0564686598932, 1722.2938595176042, 53502.394928152215, 55342.0, 56123.0, 56171.43828561703, 57267.427325726625, 9843.606255749834, 9953.701388958343, 10010.699679009642, 10031.949840250752, 10037.749056273506, 12443.564475243504, 12493.625191244277, 12504.31226282545, 12508.061895357885, 12524.123311368117, 7122.715091396286, 7124.323189297009, 7129.857402851914, 7181.605011724405, 7190.496665233488, 6970.0, 7047.43620510358, 7270.745523906638, 7333.449991250677, 7344.963275183697, 4073.9592604074173, 4180.163967206571, 4240.321548552217, 4254.106637606075, 4273.9358909616385, 1760.4982579964649, 1808.6111486030566, 1817.591042015536, 1834.5321942904475, 1838.9908050459662, 813.7558732380262, 904.2991681446931, 907.9273658107336, 930.4882314727008, 966.6906589891308, 15311.0, 15346.0, 15687.68624627501, 15789.368425262861, 16104.516864494084, 818.6193420059701, 825.4180802534199, 832.1719888710651, 877.8463768840427, 931.5109567477128, 8932.732018039469, 8951.194392504705, 8990.775230619156, 9154.954225228832, 9346.672866449777, 513989.0, 516464.0, 518199.0109829767, 532403.0, 538128.0, 70959.64520177366, 71818.2818171822, 73163.26836731564, 73167.63416182886, 74435.0, 1081.3998230981724, 1091.3233795046963, 1119.7144728094283, 1122.180808010157, 1127.4193790198055, 13644.249566273951, 13975.930120349332, 14181.787273191117, 14320.06919550226, 14504.129752214902, 21752.564948701252, 23626.52746945086, 29524.704752952195, 29576.556351655174, 30824.0, 39711.0, 40717.59282407256, 41434.1713165741, 42030.579694202665, 42333.153336933705, 8743.737687869374, 8874.64501419936, 8878.378513503993, 9072.637094516145, 9080.273578113867, 12371.938140309601, 12933.094683372074, 15010.399584016517, 15397.84602153964, 15581.610459738597, 13029.481785377484, 13034.152780069266, 13221.074524783173, 13292.601221963356, 13470.663233419244, 12929.482820687443, 13014.544490942772, 13163.53927612529, 13346.399412026289, 13495.0, 12846.229226246454, 13169.209847408803, 13351.132176408502, 13397.799033014708, 13537.458501659823, 9027.23268522183, 9049.366544341832, 9060.864087038568, 9099.044600317136, 9197.172254497127, 12895.742085158432, 12972.675683107998, 13140.934295328845, 13148.276844773629, 13772.931135344259], "unit": "ms", "name": "jquery.html", "value": 8194.164568656923}, {"lowerIsBetter": false, "replicates": [1490.143167678585, 1679.9916000419998, 1755.3768412213665, 1772.8936263824164, 1774.7958984716756, 6206.379362063792, 6355.777547785829, 6896.4827637927165, 7152.570845749258, 7223.674934627941, 7241.131064272295, 7388.113426388841, 7397.371223446014, 7402.925970740291, 7453.888191677115, 2059.2792522617037, 2092.319996001298, 2098.0244186453297, 2098.9055492502875, 2099.6640537514, 2036.8065033821838, 2100.2439121916173, 2102.1906565972135, 2106.515501434671, 2116.2381542644634, 2029.736134302546, 2054.496648321156, 2062.9071691773906, 2081.885496297703, 2082.729245198122, 2075.4811297175706, 2089.9477513062143, 2095.1200495791804, 2096.95806083879, 2105.905234264462, 2041.2141325589607, 2072.512959454527, 2074.6265672179, 2075.740532433446, 2080.0431801371387, 6935.375816176518, 6947.201071876749, 7053.788386348418, 7065.92934070663, 7088.078549788546, 4202.516710578261, 4281.422008028907, 4281.678874084456, 4282.143571285756, 4320.740755554677, 2668.7731542818883, 2690.515707172708, 2714.9185524434297, 2728.6589176352954, 2747.2719729271757, 838.9035260945009, 859.1408591408591, 867.2931560777946, 884.7168905950099, 884.8938127424686, 9897.15874150698, 9924.95037524815, 9956.651517196935, 9963.750906227402, 9986.400815950994, 3908.804559772, 3921.6470517653547, 3925.3130702127014, 3938.4879965604287, 3953.940690889639, 8616.095309992486, 8631.6978905738, 8638.352123590756, 8642.3950323478, 8648.09195034525, 4309.762963037, 4356.411884395629, 4392.626626736763, 4397.8240870364825, 4425.203463376623, 3280.3603297356785, 3347.7656564040285, 3857.3056849767313, 3977.1449138434796, 3977.880663580097, 3431.571053618298, 3514.806685632315, 3545.4150065239464, 3548.8935331940083, 3564.6435356464144, 1133.2237417369129, 1151.4933429291252, 1154.682462322851, 1160.0, 1167.270455965022, 1181.9940900295614, 1191.6722901202238, 1202.7774861650623, 1227.9201851879777, 1241.9689507762378, 6961.338672826073, 7009.264027277164, 7050.5769653820935, 7056.188538318159, 7067.257937916547, 401.33979603551995, 401.76697515440975, 402.7784718404866, 407.694229328004, 409.56586018820144, 5395.838124856261, 5454.263674403984, 5457.836264912059, 5459.044667183227, 5473.75368108436, 8714.128587141362, 8790.560471976376, 8882.777930551658, 8949.373543851998, 8986.370954033286, 8801.647934082564, 8831.249343805848, 8850.20348168668, 8892.244159246537, 8904.910950890539, 6653.767118150841, 6902.482313826483, 6993.090898183305, 7002.284440312156, 7015.263397343308, 6536.575122617015, 6568.113304703995, 6577.671116444254, 6579.934200657932, 6597.670116494252, 7184.784456466315, 7308.123025237006, 7375.11498620169, 7491.325780679765, 7498.0, 7413.888791668237, 7557.584332861746, 7565.848683026419, 7601.695932162873, 7619.314261716472, 5525.392206857162, 5784.566157538117, 6146.631202127886, 6385.393387628168, 6439.452646525097, 7031.578105313698, 7054.329838665319, 7059.5058345915295, 7074.327938845801, 7090.113735783028, 6480.57876238043, 6576.572522786004, 6583.901241481286, 6609.735610575715, 6802.285759995129, 6312.116303717391, 6376.0, 6384.425401713868, 6410.262819775599, 6446.4520515756685, 6220.129181914626, 6266.843328916813, 6282.623042617275, 6286.4342209201395, 6291.02489114188, 5828.0, 5848.385919478394, 5913.822585322448, 5937.139114828412, 5957.285125784933, 5909.113632954919, 5961.672108033927, 5973.701314934149, 6000.0999850022845, 6005.849853753516], "unit": "ms", "name": "mootools.html", "value": 4054.1524936336596}, {"lowerIsBetter": false, "replicates": [274.62513668842035, 277.4741864167403, 282.87836230420925, 284.3899834854238, 287.5471132965579, 5251.658642188255, 5390.056740070482, 5492.588055895809, 5554.611177217591, 5583.106702927533, 5441.5102640762425, 5493.368262649797, 5534.501894829465, 5535.972320138394, 5539.335279766434, 4237.4279472271155, 4239.025024244418, 4239.3852891330735, 4241.597048280424, 4246.214450326684, 4224.873253802375, 4240.27915254406, 4241.130568233505, 4248.511421186557, 4255.4467919170465, 4182.2681030819485, 4185.8534951276715, 4198.0344520760245, 4202.579742025789, 4206.263903816835, 4088.4480595119576, 4192.308269135589, 4196.076863090146, 4201.0, 4211.957880421187, 3607.9098022549383, 3610.332088563624, 3637.0907273181706, 3640.4357324614725, 3649.361361761681, 5031.698098114125, 5201.739913004372, 5319.521243088102, 5331.546818520431, 5345.1714984177515, 4688.460827004904, 4790.880227994328, 4816.879578010543, 4820.63845211607, 4828.661993660445, 5713.314402271712, 5741.081426971707, 5751.396103409165, 5754.6547207167705, 5757.82726518201, 3944.5266568011734, 3949.624785645359, 3953.9011524711823, 3956.920861582781, 3958.129211573478, 5886.941130588725, 6026.156338112624, 6037.396260373971, 6056.121862329937, 6060.939390606126, 4051.777152256654, 4055.8377664893665, 4067.5525692173837, 4067.7559346439307, 4075.2664520386024, 4138.151678905817, 4145.502539695256, 4147.896302592399, 4148.128892932457, 4153.480814898137, 4772.809087636525, 4777.904441911142, 4784.808607655725, 4787.16224660683, 4788.353572267769, 5656.660600363992, 5763.596548241583, 5767.423257674283, 5771.88456230873, 5780.826575202751, 1431.6921861799556, 1460.0801495058045, 1460.1020372471066, 1463.2829913342598, 1463.8097047383985, 968.5157421289356, 969.9951500242454, 970.8203982263304, 994.4033579852031, 994.7015895231547, 4973.8010479581135, 4982.825601104017, 4985.277134815431, 4990.675606085593, 4997.350344455198, 5887.470127688529, 5943.821685349447, 5945.910811337833, 5958.6722730249385, 5967.910481342783, 4997.100521906019, 5002.274670172877, 5003.124453220672, 5006.199008158677, 5011.874703132378, 3132.451820931328, 3192.74458043356, 3224.822634755111, 3231.1760501072076, 3232.1273256221157, 5610.410906854803, 5634.549236061105, 5635.69003704792, 5638.35158956717, 5646.887062258732, 6009.128676341993, 6098.0, 6126.417990291005, 6215.06773983897, 6227.937720622826, 5655.151727240865, 5659.066254068115, 5665.461781130786, 5672.4894759471845, 5706.144078388275, 5969.641821490724, 5985.910211346921, 6009.969950150221, 6016.518678505621, 6018.458338749533, 5778.711064446845, 5885.882282354414, 5887.293524777054, 5894.557908156991, 5897.498712609305, 5657.4059723728415, 5682.801101961411, 5690.402507736628, 5692.943070569241, 5693.174489698888, 3957.406389041667, 3995.760254384746, 4008.1983603278877, 4008.4388185654616, 4011.939820902747, 6011.6994150293185, 6035.78874739382, 6037.184980027816, 6045.093236014633, 6060.272767267779, 5685.175649530712, 5812.070068789142, 5812.128180772918, 5814.5639077068545, 5825.0679891217205, 5805.82582522525, 5812.244408226903, 5812.680302583399, 5820.417958204146, 5820.70896455184, 5683.0, 5688.488036076773, 5690.2887139107615, 5699.8860022800145, 5704.914426283692, 5647.407022262768, 5802.723400851806, 5831.979403604437, 5841.065429531254, 5876.1773351729935, 5676.943230567642, 5681.346645135697, 5689.2319536862, 5720.11338242573, 5727.713614319351], "unit": "ms", "name": "prototype.html", "value": 4297.762950167725}, {"lowerIsBetter": false, "replicates": [677.86103848711, 709.8904471715771, 761.2805898425986, 767.9709189685822, 794.1343935110729, 10454.059134677878, 10627.787444251111, 10655.0, 10726.624568140116, 10736.516856741455, 10960.451977401139, 11068.557257709703, 11109.833352499698, 11110.833337499944, 11112.333260004405, 632.3486808587139, 636.6912047656883, 796.2157275084038, 797.2227078598378, 814.7515007922581, 818.0469752738082, 819.6803246733749, 826.099551488877, 827.0571548434789, 828.2380210206625, 854.2994744309668, 856.8072183758667, 858.8797568340406, 859.1923591823665, 862.8964524257098, 847.9448835825651, 848.3171047306915, 850.1540966738104, 852.5609311204704, 852.9701460448855, 633.5976654824174, 634.0299342006691, 635.4408120853666, 635.5392340553108, 635.7361694896613, 11126.109911207164, 11198.888011119867, 11238.213325067249, 11261.324320540794, 11264.887351126466, 9786.41281523111, 9940.25448091396, 11093.445327733662, 11957.461914213882, 12363.320017399039, 9347.0, 9513.429194248367, 9580.329376943617, 9733.756656083584, 9786.90213097867, 3264.9020529384156, 3282.1302354875975, 3291.4240007998505, 3296.8186749728757, 3299.5215693724276, 41332.79333603313, 42096.0, 42199.7890010548, 42496.57503424988, 42633.0, 9396.436213827192, 9432.90567094334, 9488.905110948941, 9545.47499887499, 9617.374870633386, 16287.59281017984, 16414.589635259214, 16447.09540975234, 16534.586635334213, 16555.420560280334, 6245.718942647592, 6292.653904035322, 6362.968185159045, 6366.236051673736, 6439.259485159267, 3397.8980630581123, 3420.196253880336, 3440.913977150541, 3447.3450044491465, 3517.876874309438, 2570.0619273964867, 2585.379508917884, 2602.700689420703, 2602.7527384898403, 2616.136674897279, 471.08374212157025, 472.95270472953115, 476.49253544974493, 478.88746144655977, 481.53772378517016, 511.8771494841211, 512.0680361741595, 574.7327492715907, 597.9162917191596, 602.9487493563096, 7179.210286868441, 7218.314260145383, 7246.058012458347, 7356.926430735732, 7386.74146404884, 485.6794515619674, 500.40451862283766, 513.599392473871, 538.3835508342926, 564.8533477041613, 3596.6942809861457, 3597.568291805, 3673.366111163487, 3715.535558055243, 3768.0, 48897.75551122222, 49007.50992490101, 50264.24603630875, 50346.0, 50775.0, 40226.79886600548, 40559.0, 40765.592344076176, 40778.38832417516, 41028.79485602613, 40341.79829100836, 41307.7934610325, 41344.793276032826, 41370.0, 41494.37758433626, 7509.51188172767, 7714.961425192838, 7824.6870125194355, 8022.478538894953, 8053.516788992679, 30234.395312094075, 30716.69283307138, 30813.537796933513, 30894.53658195174, 31323.216919577193, 41159.1768164641, 41320.586794131676, 41330.586694132675, 41649.79175104105, 41970.58029419789, 10194.0, 10274.537645805807, 10319.793604128026, 10473.423961682181, 10966.890331096905, 11444.94277528607, 11521.135914806591, 11538.653840384803, 11583.247088939192, 11615.419229038345, 10737.570497180337, 10787.6224332148, 10816.891831081588, 10967.945160274467, 11457.770844583229, 10167.745806354604, 10730.678079657622, 11094.0, 11407.885921140682, 11446.313221206754, 10711.732206694895, 10877.0, 11151.665450036511, 11485.48315325829, 11491.770164596493, 9322.580483878377, 9451.858222126812, 9487.335886488156, 9534.97888989796, 9625.470599117116, 8676.522791246542, 8716.956415217883, 9275.0, 9375.671851485438, 9541.713748587554], "unit": "ms", "name": "yui.html", "value": 5693.327463813527}], "name": "dromaeo_css", "value": 6357.431333942285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 112.0, 112.0, 124.0, 113.0, 111.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 156.0, 164.0, 129.0, 169.0, 169.0, 138.0, 168.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 165.0, 175.0, 162.0, 163.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 72.0, 73.0, 73.0, 72.0, 148.0, 76.0, 71.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 135.0, 93.0, 95.0, 94.0, 133.0, 95.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 112.0, 110.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 147.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 72.0, 73.0, 73.0, 76.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 106.0, 84.0, 85.0, 86.0, 86.0, 86.0, 83.0, 91.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [133.0, 121.0, 123.0, 123.0, 134.0, 125.0, 122.0, 135.0, 131.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [132.0, 143.0, 146.0, 144.0, 148.0, 146.0, 157.0, 162.0, 144.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 71.0, 73.0, 71.0, 68.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1541.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.77179106936893], "unit": "score", "name": "Richards", "value": 214.24783800000003}, {"lowerIsBetter": false, "replicates": [183.21729571271527], "unit": "score", "name": "DeltaBlue", "value": 360.87204400000013}, {"lowerIsBetter": false, "replicates": [277.1618625277162], "unit": "score", "name": "Encrypt", "value": 960.3810479999997}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [587.5440658049354], "unit": "score", "name": "Splay", "value": 138.69768199999996}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21494.13850614897}]} 14:23:11 INFO - RETURN: dromaeo_css: 6357.43 14:23:11 INFO - RETURN: kraken: 1541.40 14:23:11 INFO - RETURN: v8_7: 21494.14 14:23:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21494.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1541.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6357.43"}}} 14:23:11 INFO - Return code: 0 14:23:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:11 INFO - # TBPL SUCCESS # 14:23:11 INFO - Running post-action listener: _resource_record_post_action 14:23:11 INFO - Running post-run listener: _resource_record_post_run 14:23:12 INFO - Total resource usage - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 514113536; Read time: 0; Write time: 1450408 14:23:12 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 244527104; Read time: 0; Write time: 1015800 14:23:12 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 269586432; Read time: 0; Write time: 434608 14:23:12 INFO - Running post-run listener: _upload_blobber_files 14:23:12 INFO - Blob upload gear active. 14:23:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:23:12 INFO - Copying logs to upload dir... 14:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.979887 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-05 14:23:12.120101) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.123688) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010147 build_url: 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.177184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-05 14:23:12.177523) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449352550.134396-878738024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 1.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-05 14:23:13.557352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 14:23:13.557678) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 14:23:13.558207) ========= ========= Total master_lag: 1.58 =========