builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1449350711.24 results: success (0) buildid: 20151205122729 builduid: cd79cb1f6d1c49e2b547135fb0fc1405 revision: 60eb5c874c64990bc04f5405550060dda2d2f235 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.239687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.240123) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.240401) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.304206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.304481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.393552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.393807) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.442492) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.442753) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.443081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.443362) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 13:25:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2015-12-05 13:25:11 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.565019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.565347) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064407 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.641273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:11.641887) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60eb5c874c64990bc04f5405550060dda2d2f235 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 60eb5c874c64990bc04f5405550060dda2d2f235 --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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 13:25:11,874 truncating revision to first 12 chars 2015-12-05 13:25:11,874 Setting DEBUG logging. 2015-12-05 13:25:11,874 attempt 1/10 2015-12-05 13:25:11,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60eb5c874c64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 13:25:12,221 unpacking tar archive at: fx-team-60eb5c874c64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:12.279448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:12.279755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:12.290300) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:12.290609) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 13:25:12.291057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-05 13:25:12.291418) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:12 INFO - MultiFileLogger online at 20151205 13:25:12 in /builds/slave/test 13:25:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:25:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:12 INFO - {'append_to_log': False, 13:25:12 INFO - 'base_work_dir': '/builds/slave/test', 13:25:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:25:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:12 INFO - 'branch': 'Fx-Team-Non-PGO', 13:25:12 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:12 INFO - 'config_files': ('talos/linux_config.py',), 13:25:12 INFO - 'default_actions': ('clobber', 13:25:12 INFO - 'read-buildbot-config', 13:25:12 INFO - 'download-and-extract', 13:25:12 INFO - 'populate-webroot', 13:25:12 INFO - 'create-virtualenv', 13:25:12 INFO - 'install', 13:25:12 INFO - 'run-tests'), 13:25:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:12 INFO - 'download_minidump_stackwalk': True, 13:25:12 INFO - 'download_symbols': 'ondemand', 13:25:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:12 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:12 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:12 INFO - 'installer_path': 'installer.exe', 13:25:12 INFO - 'log_level': 'info', 13:25:12 INFO - 'log_name': 'talos', 13:25:12 INFO - 'log_to_console': True, 13:25:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:12 INFO - 'opt_config_files': (), 13:25:12 INFO - 'pip_index': False, 13:25:12 INFO - 'sps_profile': False, 13:25:12 INFO - 'sps_profile_interval': 0, 13:25:12 INFO - 'suite': 'dromaeojs-e10s', 13:25:12 INFO - 'system_bits': '64', 13:25:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:12 INFO - 'title': 'talos-linux64-ix-027', 13:25:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:12 INFO - 'use_talos_json': True, 13:25:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:12 INFO - 'work_dir': 'build'} 13:25:12 INFO - ##### 13:25:12 INFO - ##### Running clobber step. 13:25:12 INFO - ##### 13:25:12 INFO - Running pre-action listener: _resource_record_pre_action 13:25:12 INFO - Running main action method: clobber 13:25:12 INFO - rmtree: /builds/slave/test/build 13:25:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:16 INFO - Running post-action listener: _resource_record_post_action 13:25:16 INFO - ##### 13:25:16 INFO - ##### Running read-buildbot-config step. 13:25:16 INFO - ##### 13:25:16 INFO - Running pre-action listener: _resource_record_pre_action 13:25:16 INFO - Running main action method: read_buildbot_config 13:25:16 INFO - Using buildbot properties: 13:25:16 INFO - { 13:25:16 INFO - "properties": { 13:25:16 INFO - "buildnumber": 808, 13:25:16 INFO - "product": "firefox", 13:25:16 INFO - "script_repo_revision": "production", 13:25:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:25:16 INFO - "repository": "", 13:25:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:25:16 INFO - "buildid": "20151205122729", 13:25:16 INFO - "slavename": "talos-linux64-ix-027", 13:25:16 INFO - "pgo_build": "False", 13:25:16 INFO - "basedir": "/builds/slave/test", 13:25:16 INFO - "project": "", 13:25:16 INFO - "platform": "ubuntu64_hw", 13:25:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:25:16 INFO - "slavebuilddir": "test", 13:25:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:25:16 INFO - "branch": "fx-team", 13:25:16 INFO - "repo_path": "integration/fx-team", 13:25:16 INFO - "stage_platform": "linux64", 13:25:16 INFO - "builduid": "cd79cb1f6d1c49e2b547135fb0fc1405", 13:25:16 INFO - "revision": "60eb5c874c64990bc04f5405550060dda2d2f235" 13:25:16 INFO - }, 13:25:16 INFO - "sourcestamp": { 13:25:16 INFO - "repository": "", 13:25:16 INFO - "hasPatch": false, 13:25:16 INFO - "project": "", 13:25:16 INFO - "branch": "fx-team-linux64-talos", 13:25:16 INFO - "changes": [ 13:25:16 INFO - { 13:25:16 INFO - "category": null, 13:25:16 INFO - "files": [ 13:25:16 INFO - { 13:25:16 INFO - "url": null, 13:25:16 INFO - "name": "https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:25:16 INFO - } 13:25:16 INFO - ], 13:25:16 INFO - "repository": "", 13:25:16 INFO - "rev": "60eb5c874c64990bc04f5405550060dda2d2f235", 13:25:16 INFO - "who": "ryanvm@gmail.com", 13:25:16 INFO - "when": 1449350638, 13:25:16 INFO - "number": 6799816, 13:25:16 INFO - "comments": "Merge m-c to fx-team. a=merge", 13:25:16 INFO - "project": "", 13:25:16 INFO - "at": "Sat 05 Dec 2015 13:23:58", 13:25:16 INFO - "branch": "fx-team-linux64-talos", 13:25:16 INFO - "revlink": "", 13:25:16 INFO - "properties": [ 13:25:16 INFO - [ 13:25:16 INFO - "buildid", 13:25:16 INFO - "20151205122729", 13:25:16 INFO - "Change" 13:25:16 INFO - ], 13:25:16 INFO - [ 13:25:16 INFO - "builduid", 13:25:16 INFO - "cd79cb1f6d1c49e2b547135fb0fc1405", 13:25:16 INFO - "Change" 13:25:16 INFO - ], 13:25:16 INFO - [ 13:25:16 INFO - "pgo_build", 13:25:16 INFO - "False", 13:25:16 INFO - "Change" 13:25:16 INFO - ] 13:25:16 INFO - ], 13:25:16 INFO - "revision": "60eb5c874c64990bc04f5405550060dda2d2f235" 13:25:16 INFO - } 13:25:16 INFO - ], 13:25:16 INFO - "revision": "60eb5c874c64990bc04f5405550060dda2d2f235" 13:25:16 INFO - } 13:25:16 INFO - } 13:25:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:25:16 INFO - Running post-action listener: _resource_record_post_action 13:25:16 INFO - ##### 13:25:16 INFO - ##### Running download-and-extract step. 13:25:16 INFO - ##### 13:25:16 INFO - Running pre-action listener: _resource_record_pre_action 13:25:16 INFO - Running main action method: download_and_extract 13:25:16 INFO - mkdir: /builds/slave/test/build/tests 13:25:16 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')]} 13:25:16 INFO - https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:25:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/test_packages.json 13:25:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/test_packages.json 13:25:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:25:20 INFO - Downloaded 1302 bytes. 13:25:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:25:20 INFO - Using the following test package requirements: 13:25:20 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:20 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:25:20 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'jsshell-linux-x86_64.zip'], 13:25:20 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:25:20 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:20 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:25:20 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:25:20 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:25:20 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:20 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:25:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:25:20 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')]} 13:25:20 INFO - https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:25:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:30 INFO - Downloaded 21849117 bytes. 13:25:30 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 13:25:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:30 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 13:25:31 INFO - Return code: 0 13:25:31 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 13:25:31 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')]} 13:25:31 INFO - https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:25:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:35 INFO - Downloaded 21849117 bytes. 13:25:35 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 13:25:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:25:35 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 13:25:36 INFO - Return code: 0 13:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:36 INFO - https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:37 INFO - Downloaded 11132001 bytes. 13:25:37 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 13:25:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:37 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 13:25:38 INFO - Return code: 0 13:25:38 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')]} 13:25:38 INFO - https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:25:39 INFO - Downloaded 57706636 bytes. 13:25:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:25:39 INFO - mkdir: /builds/slave/test/properties 13:25:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:39 INFO - Contents: 13:25:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:25:39 INFO - Running post-action listener: _resource_record_post_action 13:25:39 INFO - Running post-action listener: set_extra_try_arguments 13:25:39 INFO - ##### 13:25:39 INFO - ##### Running populate-webroot step. 13:25:39 INFO - ##### 13:25:39 INFO - Running pre-action listener: _resource_record_pre_action 13:25:39 INFO - Running main action method: populate_webroot 13:25:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:25:39 INFO - '../fennec_ids.txt'], 13:25:39 INFO - 'tests': ['tcheck2']}, 13:25:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:39 INFO - '--tppagecycles', 13:25:39 INFO - '7'], 13:25:39 INFO - 'tests': ['tsvgm']}}, 13:25:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:25:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:25:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:25:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'tests': ['damp', 'tps']}, 13:25:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['damp', 'tps']}, 13:25:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:25:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:39 INFO - 'other': {'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'other_l64': {'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'other_nol64': {'tests': ['a11yr', 13:25:39 INFO - 'ts_paint', 13:25:39 INFO - 'tpaint', 13:25:39 INFO - 'sessionrestore', 13:25:39 INFO - 'sessionrestore_no_auto_restore']}, 13:25:39 INFO - 'svgr': {'tests': ['tsvgx', 13:25:39 INFO - 'tsvgr_opacity', 13:25:39 INFO - 'tart', 13:25:39 INFO - 'tscrollx', 13:25:39 INFO - 'cart']}, 13:25:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['tsvgx', 13:25:39 INFO - 'tsvgr_opacity', 13:25:39 INFO - 'tart', 13:25:39 INFO - 'tscrollx', 13:25:39 INFO - 'cart']}, 13:25:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'tests': ['tp5o']}, 13:25:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'talos_options': ['--e10s'], 13:25:39 INFO - 'tests': ['tp5o']}, 13:25:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'talos_options': ['--xperf_path', 13:25:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:39 INFO - 'tests': ['tp5n']}, 13:25:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:39 INFO - 'talos_options': ['--e10s', 13:25:39 INFO - '--xperf_path', 13:25:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:39 INFO - 'tests': ['tp5n']}}, 13:25:39 INFO - 'talos.zip': {'path': '', 13:25:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:39 INFO - Running post-action listener: _resource_record_post_action 13:25:39 INFO - ##### 13:25:39 INFO - ##### Running create-virtualenv step. 13:25:39 INFO - ##### 13:25:39 INFO - Running pre-action listener: _resource_record_pre_action 13:25:39 INFO - Running main action method: create_virtualenv 13:25:39 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:39 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 13:25:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:39 INFO - Using real prefix '/usr' 13:25:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:42 INFO - Installing pip.................done. 13:25:42 INFO - Return code: 0 13:25:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:42 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:42 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 13:25:42 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 13:25:42 INFO - Using env: {'DISPLAY': ':0', 13:25:42 INFO - 'HOME': '/home/cltbld', 13:25:42 INFO - 'LANG': 'en_US.UTF-8', 13:25:42 INFO - 'LANGUAGE': 'en_US:en', 13:25:42 INFO - 'LOGNAME': 'cltbld', 13:25:42 INFO - 'MAIL': '/var/mail/cltbld', 13:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:42 INFO - 'MOZ_NO_REMOTE': '1', 13:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:42 INFO - 'NO_EM_RESTART': '1', 13:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:42 INFO - 'PWD': '/builds/slave/test', 13:25:42 INFO - 'SHELL': '/bin/bash', 13:25:42 INFO - 'SHLVL': '1', 13:25:42 INFO - 'TERM': 'linux', 13:25:42 INFO - 'TMOUT': '86400', 13:25:42 INFO - 'USER': 'cltbld', 13:25:42 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:42 INFO - '_': '/tools/buildbot/bin/python'} 13:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:42 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 13:25:42 INFO - Cleaning up... 13:25:42 INFO - Return code: 0 13:25:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:42 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:42 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 13:25:42 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 13:25:42 INFO - Using env: {'DISPLAY': ':0', 13:25:42 INFO - 'HOME': '/home/cltbld', 13:25:42 INFO - 'LANG': 'en_US.UTF-8', 13:25:42 INFO - 'LANGUAGE': 'en_US:en', 13:25:42 INFO - 'LOGNAME': 'cltbld', 13:25:42 INFO - 'MAIL': '/var/mail/cltbld', 13:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:42 INFO - 'MOZ_NO_REMOTE': '1', 13:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:42 INFO - 'NO_EM_RESTART': '1', 13:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:42 INFO - 'PWD': '/builds/slave/test', 13:25:42 INFO - 'SHELL': '/bin/bash', 13:25:42 INFO - 'SHLVL': '1', 13:25:42 INFO - 'TERM': 'linux', 13:25:42 INFO - 'TMOUT': '86400', 13:25:42 INFO - 'USER': 'cltbld', 13:25:42 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:42 INFO - '_': '/tools/buildbot/bin/python'} 13:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:42 INFO - Downloading/unpacking psutil>=0.7.1 13:25:42 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 13:25:42 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 13:25:42 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 13:25:42 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 13:25:42 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 13:25:42 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 13:25:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:25:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:44 INFO - Installing collected packages: psutil 13:25:44 INFO - Running setup.py install for psutil 13:25:44 INFO - building 'psutil._psutil_linux' extension 13:25:44 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 13:25:44 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 13:25:44 INFO - building 'psutil._psutil_posix' extension 13:25:44 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 13:25:44 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 13:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:44 INFO - Successfully installed psutil 13:25:44 INFO - Cleaning up... 13:25:44 INFO - Return code: 0 13:25:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:25:44 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')]} 13:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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')]} 13:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:44 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 13:25:44 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 13:25:44 INFO - Using env: {'DISPLAY': ':0', 13:25:44 INFO - 'HOME': '/home/cltbld', 13:25:44 INFO - 'LANG': 'en_US.UTF-8', 13:25:44 INFO - 'LANGUAGE': 'en_US:en', 13:25:44 INFO - 'LOGNAME': 'cltbld', 13:25:44 INFO - 'MAIL': '/var/mail/cltbld', 13:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:44 INFO - 'MOZ_NO_REMOTE': '1', 13:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:44 INFO - 'NO_EM_RESTART': '1', 13:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:44 INFO - 'PWD': '/builds/slave/test', 13:25:44 INFO - 'SHELL': '/bin/bash', 13:25:44 INFO - 'SHLVL': '1', 13:25:44 INFO - 'TERM': 'linux', 13:25:44 INFO - 'TMOUT': '86400', 13:25:44 INFO - 'USER': 'cltbld', 13:25:44 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:44 INFO - '_': '/tools/buildbot/bin/python'} 13:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:25:45 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 13:25:45 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 13:25:45 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 13:25:45 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 13:25:45 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 13:25:45 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 13:25:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:25:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:25:46 INFO - Installing collected packages: mozsystemmonitor 13:25:46 INFO - Running setup.py install for mozsystemmonitor 13:25:46 INFO - Successfully installed mozsystemmonitor 13:25:46 INFO - Cleaning up... 13:25:46 INFO - Return code: 0 13:25:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:46 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 13:25:46 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 13:25:46 INFO - Using env: {'DISPLAY': ':0', 13:25:46 INFO - 'HOME': '/home/cltbld', 13:25:46 INFO - 'LANG': 'en_US.UTF-8', 13:25:46 INFO - 'LANGUAGE': 'en_US:en', 13:25:46 INFO - 'LOGNAME': 'cltbld', 13:25:46 INFO - 'MAIL': '/var/mail/cltbld', 13:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:46 INFO - 'MOZ_NO_REMOTE': '1', 13:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:46 INFO - 'NO_EM_RESTART': '1', 13:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:46 INFO - 'PWD': '/builds/slave/test', 13:25:46 INFO - 'SHELL': '/bin/bash', 13:25:46 INFO - 'SHLVL': '1', 13:25:46 INFO - 'TERM': 'linux', 13:25:46 INFO - 'TMOUT': '86400', 13:25:46 INFO - 'USER': 'cltbld', 13:25:46 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:46 INFO - '_': '/tools/buildbot/bin/python'} 13:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:48 INFO - Downloading blobuploader-1.2.4.tar.gz 13:25:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:25:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:25:48 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 13:25:48 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 13:25:48 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 13:25:48 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 13:25:48 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 13:25:48 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 13:25:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:25:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:49 INFO - Downloading docopt-0.6.1.tar.gz 13:25:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:25:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:25:49 INFO - Running setup.py install for blobuploader 13:25:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:25:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:25:49 INFO - Running setup.py install for requests 13:25:49 INFO - Running setup.py install for docopt 13:25:50 INFO - Successfully installed blobuploader requests docopt 13:25:50 INFO - Cleaning up... 13:25:50 INFO - Return code: 0 13:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:50 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:50 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 13:25:50 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 13:25:50 INFO - Using env: {'DISPLAY': ':0', 13:25:50 INFO - 'HOME': '/home/cltbld', 13:25:50 INFO - 'LANG': 'en_US.UTF-8', 13:25:50 INFO - 'LANGUAGE': 'en_US:en', 13:25:50 INFO - 'LOGNAME': 'cltbld', 13:25:50 INFO - 'MAIL': '/var/mail/cltbld', 13:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:50 INFO - 'MOZ_NO_REMOTE': '1', 13:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:50 INFO - 'NO_EM_RESTART': '1', 13:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:50 INFO - 'PWD': '/builds/slave/test', 13:25:50 INFO - 'SHELL': '/bin/bash', 13:25:50 INFO - 'SHLVL': '1', 13:25:50 INFO - 'TERM': 'linux', 13:25:50 INFO - 'TMOUT': '86400', 13:25:50 INFO - 'USER': 'cltbld', 13:25:50 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:50 INFO - '_': '/tools/buildbot/bin/python'} 13:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:50 INFO - Running setup.py (path:/tmp/pip-2S6w1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:50 INFO - Running setup.py (path:/tmp/pip-onRZ3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:50 INFO - Running setup.py (path:/tmp/pip-DZSzlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:50 INFO - Running setup.py (path:/tmp/pip-1w_vGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:50 INFO - Running setup.py (path:/tmp/pip-dXbUC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:50 INFO - Running setup.py (path:/tmp/pip-tBXaRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:50 INFO - Running setup.py (path:/tmp/pip-oPXfTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:50 INFO - Running setup.py (path:/tmp/pip-XqNBOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:50 INFO - Running setup.py (path:/tmp/pip-H0fx2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:50 INFO - Running setup.py (path:/tmp/pip-WW50AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:51 INFO - Running setup.py (path:/tmp/pip-HokF2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:51 INFO - Running setup.py (path:/tmp/pip-uBKICX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:51 INFO - Running setup.py (path:/tmp/pip-958qrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:51 INFO - Running setup.py (path:/tmp/pip-yHUxuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:51 INFO - Running setup.py (path:/tmp/pip-W00WQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:51 INFO - Running setup.py (path:/tmp/pip-MBh2uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:51 INFO - Running setup.py (path:/tmp/pip-Jzarym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:25:51 INFO - Running setup.py install for manifestparser 13:25:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:25:51 INFO - Running setup.py install for mozcrash 13:25:51 INFO - Running setup.py install for mozdebug 13:25:51 INFO - Running setup.py install for mozdevice 13:25:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:25:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:25:51 INFO - Running setup.py install for mozfile 13:25:52 INFO - Running setup.py install for mozhttpd 13:25:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozinfo 13:25:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozInstall 13:25:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozleak 13:25:52 INFO - Running setup.py install for mozlog 13:25:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for moznetwork 13:25:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozprocess 13:25:52 INFO - Running setup.py install for mozprofile 13:25:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozrunner 13:25:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for mozscreenshot 13:25:53 INFO - Running setup.py install for moztest 13:25:53 INFO - Running setup.py install for mozversion 13:25:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:25:53 INFO - Cleaning up... 13:25:53 INFO - Return code: 0 13:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:53 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 13:25:53 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 13:25:53 INFO - Using env: {'DISPLAY': ':0', 13:25:53 INFO - 'HOME': '/home/cltbld', 13:25:53 INFO - 'LANG': 'en_US.UTF-8', 13:25:53 INFO - 'LANGUAGE': 'en_US:en', 13:25:53 INFO - 'LOGNAME': 'cltbld', 13:25:53 INFO - 'MAIL': '/var/mail/cltbld', 13:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:53 INFO - 'MOZ_NO_REMOTE': '1', 13:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:53 INFO - 'NO_EM_RESTART': '1', 13:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:53 INFO - 'PWD': '/builds/slave/test', 13:25:53 INFO - 'SHELL': '/bin/bash', 13:25:53 INFO - 'SHLVL': '1', 13:25:53 INFO - 'TERM': 'linux', 13:25:53 INFO - 'TMOUT': '86400', 13:25:53 INFO - 'USER': 'cltbld', 13:25:53 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:53 INFO - '_': '/tools/buildbot/bin/python'} 13:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:53 INFO - Running setup.py (path:/tmp/pip-Qel0Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:53 INFO - Running setup.py (path:/tmp/pip-3HXZKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:53 INFO - Running setup.py (path:/tmp/pip-kA2Kex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:53 INFO - Running setup.py (path:/tmp/pip-vNwsnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:53 INFO - Running setup.py (path:/tmp/pip-6xH50w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:53 INFO - Running setup.py (path:/tmp/pip-r4figs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:53 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)) 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:53 INFO - Running setup.py (path:/tmp/pip-M2pMyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 INFO - Running setup.py (path:/tmp/pip-1ws1JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:54 INFO - Running setup.py (path:/tmp/pip-irTOdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:54 INFO - Running setup.py (path:/tmp/pip-HmGb1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:54 INFO - Running setup.py (path:/tmp/pip-ceTeed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:54 INFO - Running setup.py (path:/tmp/pip-KMziCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:54 INFO - Running setup.py (path:/tmp/pip-DJYX_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:54 INFO - Running setup.py (path:/tmp/pip-Hm6jVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:54 INFO - Running setup.py (path:/tmp/pip-HClWbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:54 INFO - Running setup.py (path:/tmp/pip-mwHq3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:54 INFO - Running setup.py (path:/tmp/pip-qohllY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:54 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)) 13:25:54 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)) 13:25:54 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)) 13:25:54 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)) 13:25:54 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)) 13:25:54 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)) 13:25:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:56 INFO - Downloading blessings-1.5.1.tar.gz 13:25:56 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 13:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:25:56 INFO - Installing collected packages: blessings 13:25:56 INFO - Running setup.py install for blessings 13:25:56 INFO - Successfully installed blessings 13:25:56 INFO - Cleaning up... 13:25:56 INFO - Return code: 0 13:25:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:25:56 INFO - Reading from file tmpfile_stdout 13:25:56 INFO - Current package versions: 13:25:56 INFO - argparse == 1.2.1 13:25:56 INFO - blessings == 1.5.1 13:25:56 INFO - blobuploader == 1.2.4 13:25:56 INFO - docopt == 0.6.1 13:25:56 INFO - manifestparser == 1.1 13:25:56 INFO - mozInstall == 1.12 13:25:56 INFO - mozcrash == 0.16 13:25:56 INFO - mozdebug == 0.1 13:25:56 INFO - mozdevice == 0.47 13:25:56 INFO - mozfile == 1.2 13:25:56 INFO - mozhttpd == 0.7 13:25:56 INFO - mozinfo == 0.9 13:25:56 INFO - mozleak == 0.1 13:25:56 INFO - mozlog == 3.1 13:25:56 INFO - moznetwork == 0.27 13:25:56 INFO - mozprocess == 0.22 13:25:56 INFO - mozprofile == 0.27 13:25:56 INFO - mozrunner == 6.11 13:25:56 INFO - mozscreenshot == 0.1 13:25:56 INFO - mozsystemmonitor == 0.0 13:25:56 INFO - moztest == 0.7 13:25:56 INFO - mozversion == 1.4 13:25:56 INFO - psutil == 3.1.1 13:25:56 INFO - requests == 1.2.3 13:25:56 INFO - wsgiref == 0.1.2 13:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:56 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 13:25:56 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 13:25:56 INFO - Using env: {'DISPLAY': ':0', 13:25:56 INFO - 'HOME': '/home/cltbld', 13:25:56 INFO - 'LANG': 'en_US.UTF-8', 13:25:56 INFO - 'LANGUAGE': 'en_US:en', 13:25:56 INFO - 'LOGNAME': 'cltbld', 13:25:56 INFO - 'MAIL': '/var/mail/cltbld', 13:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:56 INFO - 'MOZ_NO_REMOTE': '1', 13:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:56 INFO - 'NO_EM_RESTART': '1', 13:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:56 INFO - 'PWD': '/builds/slave/test', 13:25:56 INFO - 'SHELL': '/bin/bash', 13:25:56 INFO - 'SHLVL': '1', 13:25:56 INFO - 'TERM': 'linux', 13:25:56 INFO - 'TMOUT': '86400', 13:25:56 INFO - 'USER': 'cltbld', 13:25:56 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:56 INFO - '_': '/tools/buildbot/bin/python'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 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)) 13:25:57 INFO - Cleaning up... 13:25:57 INFO - Return code: 0 13:25:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:57 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 13:25:57 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 13:25:57 INFO - Using env: {'DISPLAY': ':0', 13:25:57 INFO - 'HOME': '/home/cltbld', 13:25:57 INFO - 'LANG': 'en_US.UTF-8', 13:25:57 INFO - 'LANGUAGE': 'en_US:en', 13:25:57 INFO - 'LOGNAME': 'cltbld', 13:25:57 INFO - 'MAIL': '/var/mail/cltbld', 13:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:57 INFO - 'MOZ_NO_REMOTE': '1', 13:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:57 INFO - 'NO_EM_RESTART': '1', 13:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:57 INFO - 'PWD': '/builds/slave/test', 13:25:57 INFO - 'SHELL': '/bin/bash', 13:25:57 INFO - 'SHLVL': '1', 13:25:57 INFO - 'TERM': 'linux', 13:25:57 INFO - 'TMOUT': '86400', 13:25:57 INFO - 'USER': 'cltbld', 13:25:57 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:57 INFO - '_': '/tools/buildbot/bin/python'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 INFO - Downloading/unpacking jsonschema 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:25:59 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 13:25:59 INFO - Downloading/unpacking functools32 (from jsonschema) 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:25:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:25:59 INFO - warning: no files found matching '*.txt' 13:25:59 INFO - no previously-included directories found matching 'build' 13:25:59 INFO - no previously-included directories found matching 'dist' 13:25:59 INFO - no previously-included directories found matching '.git*' 13:25:59 INFO - Installing collected packages: jsonschema, functools32 13:25:59 INFO - Running setup.py install for functools32 13:25:59 INFO - warning: no files found matching '*.txt' 13:25:59 INFO - no previously-included directories found matching 'build' 13:25:59 INFO - no previously-included directories found matching 'dist' 13:25:59 INFO - no previously-included directories found matching '.git*' 13:25:59 INFO - Successfully installed jsonschema functools32 13:25:59 INFO - Cleaning up... 13:25:59 INFO - Return code: 0 13:25:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:59 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 0x7f8f8500bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', '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 13:25:59 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 13:25:59 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 13:25:59 INFO - Using env: {'DISPLAY': ':0', 13:25:59 INFO - 'HOME': '/home/cltbld', 13:25:59 INFO - 'LANG': 'en_US.UTF-8', 13:25:59 INFO - 'LANGUAGE': 'en_US:en', 13:25:59 INFO - 'LOGNAME': 'cltbld', 13:25:59 INFO - 'MAIL': '/var/mail/cltbld', 13:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:59 INFO - 'MOZ_NO_REMOTE': '1', 13:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:59 INFO - 'NO_EM_RESTART': '1', 13:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:59 INFO - 'PWD': '/builds/slave/test', 13:25:59 INFO - 'SHELL': '/bin/bash', 13:25:59 INFO - 'SHLVL': '1', 13:25:59 INFO - 'TERM': 'linux', 13:25:59 INFO - 'TMOUT': '86400', 13:25:59 INFO - 'USER': 'cltbld', 13:25:59 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:59 INFO - '_': '/tools/buildbot/bin/python'} 13:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:59 INFO - Downloading/unpacking flake8 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:26:01 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 13:26:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:26:01 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 13:26:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 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 13:26:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:01 INFO - no previously-included directories found matching 'docs/_build' 13:26:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:26:02 INFO - Running setup.py install for pep8 13:26:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:02 INFO - no previously-included directories found matching 'docs/_build' 13:26:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:26:02 INFO - Cleaning up... 13:26:02 INFO - Return code: 0 13:26:02 INFO - Running post-action listener: _resource_record_post_action 13:26:02 INFO - Running post-action listener: _start_resource_monitoring 13:26:02 INFO - Starting resource monitoring. 13:26:02 INFO - ##### 13:26:02 INFO - ##### Running install step. 13:26:02 INFO - ##### 13:26:02 INFO - Running pre-action listener: _resource_record_pre_action 13:26:02 INFO - Running main action method: install 13:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:02 INFO - Reading from file tmpfile_stdout 13:26:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:02 INFO - Reading from file tmpfile_stdout 13:26:02 INFO - Output received: 13:26:02 INFO - Usage: mozinstall [options] installer 13:26:02 INFO - Options: 13:26:02 INFO - -h, --help show this help message and exit 13:26:02 INFO - -d DEST, --destination=DEST 13:26:02 INFO - Directory to install application into. [default: 13:26:02 INFO - "/builds/slave/test"] 13:26:02 INFO - --app=APP Application being installed. [default: firefox] 13:26:02 INFO - mkdir: /builds/slave/test/build/application 13:26:02 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'] 13:26:02 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 13:26:17 INFO - Reading from file tmpfile_stdout 13:26:17 INFO - Output received: 13:26:17 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:17 INFO - Running post-action listener: _resource_record_post_action 13:26:17 INFO - ##### 13:26:17 INFO - ##### Running run-tests step. 13:26:17 INFO - ##### 13:26:17 INFO - Running pre-action listener: _resource_record_pre_action 13:26:17 INFO - Running main action method: run_tests 13:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:17 INFO - Python 2.7.3 13:26:17 INFO - Return code: 0 13:26:17 INFO - grabbing minidump binary from tooltool 13:26:17 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')]} 13:26:17 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 0x11fb0b0>, '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 0x11fbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:17 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 13:26:17 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 13:26:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:17 INFO - Return code: 0 13:26:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:26:18 INFO - Return code: 0 13:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 13:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 13:26:18 INFO - Using env: {'DISPLAY': ':0', 13:26:18 INFO - 'HOME': '/home/cltbld', 13:26:18 INFO - 'LANG': 'en_US.UTF-8', 13:26:18 INFO - 'LANGUAGE': 'en_US:en', 13:26:18 INFO - 'LOGNAME': 'cltbld', 13:26:18 INFO - 'MAIL': '/var/mail/cltbld', 13:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:18 INFO - 'MOZ_NO_REMOTE': '1', 13:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:18 INFO - 'NO_EM_RESTART': '1', 13:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:18 INFO - 'PWD': '/builds/slave/test', 13:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:18 INFO - 'SHELL': '/bin/bash', 13:26:18 INFO - 'SHLVL': '1', 13:26:18 INFO - 'TERM': 'linux', 13:26:18 INFO - 'TMOUT': '86400', 13:26:18 INFO - 'USER': 'cltbld', 13:26:18 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262', 13:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:18 INFO - '_': '/tools/buildbot/bin/python'} 13:26:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 13:26:18 INFO - mozversion INFO | application_buildid: 20151205122729 13:26:18 INFO - mozversion INFO | application_changeset: 60eb5c874c64990bc04f5405550060dda2d2f235 13:26:18 INFO - mozversion INFO | application_display_name: Nightly 13:26:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:18 INFO - mozversion INFO | application_name: Firefox 13:26:18 INFO - mozversion INFO | application_remotingname: firefox 13:26:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:26:18 INFO - mozversion INFO | application_vendor: Mozilla 13:26:18 INFO - mozversion INFO | application_version: 45.0a1 13:26:18 INFO - mozversion INFO | platform_buildid: 20151205122729 13:26:18 INFO - mozversion INFO | platform_changeset: 60eb5c874c64990bc04f5405550060dda2d2f235 13:26:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:26:18 INFO - mozversion INFO | platform_version: 45.0a1 13:26:18 INFO - 2015-12-05 13:26:18,287 DEBUG : using testdate: 1449350778 13:26:18 INFO - 2015-12-05 13:26:18,287 DEBUG : actual date: 1449350778 13:26:18 INFO - 2015-12-05 13:26:18,365 INFO : starting webserver on 'localhost:55611' 13:26:18 INFO - 2015-12-05 13:26:18,367 INFO : Starting test suite talos-linux64-ix-027.e 13:26:18 INFO - 2015-12-05 13:26:18,367 INFO : Starting test dromaeo_css 13:26:18 INFO - 2015-12-05 13:26:18,367 DEBUG : operating with platform_type : linux_ 13:26:18 INFO - 2015-12-05 13:26:18,367 INFO : Initialising browser for dromaeo_css test... 13:26:18 INFO - 2015-12-05 13:26:18,382 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7XYbi/profile http://localhost:55611/getInfo.html 13:26:23 INFO - 2015-12-05 13:26:23,278 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:26:23 INFO - 2015-12-05 13:26:23,278 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:26:23 INFO - 2015-12-05 13:26:23,278 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:26:23 INFO - 2015-12-05 13:26:23,278 DEBUG : BROWSER_OUTPUT: __metrics 13:26:23 INFO - 2015-12-05 13:26:23,819 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] 13:26:24 INFO - 2015-12-05 13:26:24,765 INFO : Browser initialized. 13:26:24 INFO - 2015-12-05 13:26:24,765 INFO : Running cycle 1/1 for dromaeo_css test... 13:26:24 INFO - 2015-12-05 13:26:24,765 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7XYbi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:26:36 INFO - 2015-12-05 13:26:36,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 143159296 13:26:36 INFO - 2015-12-05 13:26:36,774 DEBUG : BROWSER_OUTPUT: 13:27:26 INFO - 2015-12-05 13:27:26,418 DEBUG : BROWSER_OUTPUT: 1449350846416 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] 13:29:38 INFO - 2015-12-05 13:29:38,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55611/tests/dromaeo/cssquery-ext.html) 13:29:39 INFO - 2015-12-05 13:29:39,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 146984960 13:29:39 INFO - 2015-12-05 13:29:39,789 DEBUG : BROWSER_OUTPUT: 13:32:41 INFO - 2015-12-05 13:32:41,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-ext.html (next: http://localhost:55611/tests/dromaeo/cssquery-jquery.html) 13:32:42 INFO - 2015-12-05 13:32:42,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 144162816 13:32:42 INFO - 2015-12-05 13:32:42,347 DEBUG : BROWSER_OUTPUT: 13:35:44 INFO - 2015-12-05 13:35:44,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55611/tests/dromaeo/cssquery-mootools.html) 13:35:44 INFO - 2015-12-05 13:35:44,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 145174528 13:35:44 INFO - 2015-12-05 13:35:44,710 DEBUG : BROWSER_OUTPUT: 13:38:46 INFO - 2015-12-05 13:38:46,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55611/tests/dromaeo/cssquery-prototype.html) 13:38:47 INFO - 2015-12-05 13:38:47,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 143421440 13:38:47 INFO - 2015-12-05 13:38:47,136 DEBUG : BROWSER_OUTPUT: 13:41:49 INFO - 2015-12-05 13:41:49,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55611/tests/dromaeo/cssquery-yui.html) 13:41:50 INFO - 2015-12-05 13:41:50,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 145575936 13:41:50 INFO - 2015-12-05 13:41:50,300 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-yui.html (next: http://localhost:55611/tests/dromaeo/cssquery-dojo.html) 13:44:52 INFO - 2015-12-05 13:44:52,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 147447808 13:44:52 INFO - 2015-12-05 13:44:52,954 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,956 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:44:52 INFO - 2015-12-05 13:44:52,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:44:52 INFO - 2015-12-05 13:44:52,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:44:52 INFO - 2015-12-05 13:44:52,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:44:52 INFO - 2015-12-05 13:44:52,960 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.062328185135;2706.8105232633725;2739.2330147558678;2745.5469847475156;2756.4624898144857;4589.380433641466;4695.765211739408;4792.6405519586;4793.736344501055;4880.097182021324;4700.670953033289;4728.1962066448705;4759.452662943762;4777.665563410563;4805.61555075594;4398.406215160952;4412.514623391425;4449.66627502937;4472.150291444631;4510.278355463127;507.8182827210583;4201.369794530814;4312.482502099737;4335.284678028137;4452.265376212921;4305.440292761952;4313.547077556858;4382.452193475816;4399.274119770234;4428.601425871687;4437.511873693891;4458.108378324348;4475.440569928759;4488.8877778055485;4496.482904465963;4224.366345048236;4324.264874971231;4349.478062632473;4447.666425018137;4448.733076015449;4681.133990211822;4710.4347478302825;4729.787159577827;4768.356271903318;4823.348847905558;5118.872028199287;5178.689278643294;5187.48125187482;5199.064168449678;5219.947800522022;4909.042736666352;5027.949720502821;5041.344625198737;5154.38147422308;5252.1071417858675;4747.8100875965265;4801.663883528155;4808.663393562487;4821.37322148122;4853.854384368475;5291.523762861284;5293.153095504701;5294.894102117936;5299.2845965794895;5299.894002120013;4719.528047195322;4806.7836947337455;4954.677945933503;5021.196608542616;5072.974635126875;5138.38339399267;5193.584513238932;5196.480351964773;5200.2979597754575;5237.3453318335205;4834.589059929875;5120.871978200575;5139.152039913447;5143.8456846294675;5146.588272938156;4905.9754701226975;4909.410870695468;4977.377827771528;5057.721825299644;5062.493750624908;3933.2330195612153;3951.604839516083;3954.2882281189663;3955.228730397545;3977.482927219443;3531.7527773056154;3544.8936531904083;3563.037979745506;3576.284743051348;3581.552305961755;4230.386593943923;4268.466441694788;4329.935050974238;4332.870013899588;4358.171947329997;5217.373915130209;5229.267902493654;5238.3190185276435;5239.476052394806;5243.4232234454175;4501.032278060233;4503.121891231244;4504.549545045535;4516.209663308908;4541.9545804542195;4275.743455392624;4384.6273066789045;4426.15902978433;4542.205114105019;4592.494825569184;4850.442199147144;4855.053264613366;4856.417229932431;4860.441049279308;4894.51054894522;5117.257997590403;5126.384833819965;5127.6410651254055;5142.434332223527;5183.196604526304;4714.740689262124;4836.443808962014;4838.322634831056;4840.29815676732;4844.297576851266;4909.607231421549;4983.8504844854715;4987.451380348086;4992.800287988585;5007.349044624176;5103.030424219386;5108.7445627717725;5113.846584602468;5139.023585518739;5164.9741751291;4674.462436819673;4784.952150478451;4818.325434439112;4929.778159982738;4950.059488697136;4976.029674213493;4986.077575648516;4991.47589503097;4996.275540046746;5011.348524691767;4803.663743537919;4840.29815676732;4840.443349014768;4891.29076283944;4906.852794416173;4774.976125119352;4877.804937790264;4935.8025678972435;5022.84931452057;5053.191489361684;4819.132556139928;4841.467438581823;4855.927161092516;4858.12553740316;4889.535494128052 13:44:52 INFO - 2015-12-05 13:44:52,960 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.1711445433896;574.4944448884982;587.2072701852497;591.6213623281101;593.0067137544614;34014.82992585037;34490.31019379611;34585.30829383411;34621.30757384854;34697.13257168569;36096.63903360966;36651.083722906944;36679;36739;36778;7847.4506784524965;7999.440039197259;8014.799630009267;8024.317932975675;8049.51702897828;7927;8013.919860801405;8071.556064416454;8072;8072.19278072194;7863.174366691473;7934.047914250298;7973.920260797405;8017.278444939954;8023.598820059003;7909.288164065233;8019.5188288702575;8064.677412903536;8092.514449133071;8100;7816.452848300622;7847.725329613436;7891.289783919475;7899.131095579482;7915.485493442908;36600.45099323512;36909.630903690886;36963.26073478542;36965.815170923976;37028;2583.32833463299;2640.749128832758;2640.854752988585;2649.443616840466;2704.580789977537;26040.86979565109;27224.59163112555;27589.448211035866;27758.583621245696;29443.558346624817;3306.6197387300285;3329.667033296675;3380.070480617825;3381.2730262993573;3408.7613867029318;224717;225704;228578;228730;228818;38439.61560384416;38979.41530877039;39050.41424378636;56400;56862.147067794016;37347.43978840319;37391.62608373936;37392.25215495675;37517.06207344838;37582.30879610424;11421;11534.134939879543;11563.074954003827;11574.942125289319;11590.594329198437;9532.142107210384;9586.424814511152;9618.663346782829;9706.5146742664;9749.756256093513;13207.933960330136;13253.602391928258;13294.734105317839;13328.200307981358;13356.131851429625;5424.5660347172925;5555.083411237181;5561.940932487116;5604.271444712243;5615.382307946123;857.3655494933704;907.6369452219166;946.786972931085;1053.6996955867694;1087.842262871895;26333.604995925078;26458.46346033729;26725.599116013276;26731.465370692476;26741.465170696476;948.9893263674303;977.8142152990908;985.2019863910256;1039.0544604409952;1046.1735229169024;13742.106763060368;13853.51512697071;13982.230977296347;14055.297235138201;14078.225697586526;265419;273263;273617;274050;274465;44757;45119;45153.774231128635;45156.3226551602;45344.3198352025;1174.17220859294;1175.9764804703857;1188.4057971014493;1193.2840295822612;1197.9341136237417;25186.496270074862;25907.611385829605;26204.868975655;26233.475330493664;26443.603345949443;39440;39465.40801888031;39535.60464395319;39866.402003969386;39905.40141897816;249661;249849;251416;252337;253306;29319.267018324714;29710;30026;30127.69872301249;30134.547981780728;38521.61478385292;38546;38801.805990969864;39627.20745585015;39696.40455393229;32486;32753.34493310073;33045;33274.500882486296;33717.66282337243;33167.109598176095;33195.50206746949;33458.832705836314;33679;33718.831405842815;33136;33208.1697957553;33444.99665010053;33496.49755253722;33614.159646009044;28707.569386459636;30036;30546.236344091576;30748.38638715734;30862.53706194364;23635.88182059079;23973;30633.693663063084;32175.839120804245;32750.836245818617 13:44:52 INFO - 2015-12-05 13:44:52,964 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.3166599314505;311.6836411042792;313.3998393077257;317.61251273446385;318.3235624298365;15152.09087454752;15516.612084697874;15870.761938570931;16034.83965160348;16640.33438662452;14677.192754398504;14986.325615347308;15379.38482460703;15545.222738863069;15556;4682.180618391776;5083.491650834905;5085.491450854922;5089.847304580869;5099.796008159669;5030.84907452777;5086.516780905827;5089.847304580869;5092.770825312869;5097.3118628984985;4811.254255590372;4911.803527858881;4962.429320628138;4986.975065124688;4996.32549605804;4781.474037855833;4937.432195297533;4960.925586116211;4978.751062446863;4986.5761410280165;4890.24201248807;4895.996320754237;4925.113479573675;4933.827316043958;4940.209566469383;10377.79244415115;10475.27158018926;10608.416537090457;18482.722759158623;18726.157322920502;1684.3515246630136;1736.4530172995592;1777.5200695812186;1802.8107048759823;1803.603207294393;8385.454945428528;8535.359848011423;8651.6971905983;10736;12548;1615.4622818404675;1646.0617448054613;1683.9494815155565;1686.7891513560805;1692.4753326468833;54765.452345476835;56488.71755641237;56766.71616641932;57722.422775772124;57991.42008579902;9505.857412138823;9831.213502919893;9852.113309802153;9875.604975800887;9884.901150988399;12229.571964981184;12302.446389912475;12311;12397.566085186974;12426.254424734545;6627.105340778933;6656;6665.400113989765;6669.799906002828;6686.130802995676;6269.435750782361;6289.937100628935;6343.777967771106;6345.96827015862;6357.523185761086;4084.81618327176;4117.197146556453;4121.855735049259;4125.91748165035;4148.274052040881;1731.4805558332703;1734.5689805910174;1745.65086982604;1749.4401791426876;1771.079038899765;331.2048696067273;333.32002714462226;337.0814530404677;337.2193372343018;802.626778547978;9176.31177661678;9495.240380769523;9597.712068637951;9666.516674166263;9806.705798826046;355.2043422733111;356.12571137856503;359.31550396494197;361.14769144818206;365.6508034826734;5150.40770311419;5151.356080489939;5151.562117220078;5220.060389129993;5239.790408383622;460376;461969;462494;464868;477981;70452.29547704458;70495;71501.6424917872;71695.64152179206;72901.54196916138;393.4845352588119;393.55528253074414;396.32426712455197;396.488529796565;398.1280994621769;8689.17452841979;8800.427972181787;8883.777905552155;8905.376623636283;8915.910840891507;30248.69751302547;30807.845960770053;31315.53026704647;31343.84328078345;31745.8412707935;42800.78599606982;43046.56953430551;43703.34444983264;43829.56170438255;44477;7940.682372705027;8243.422960392714;8257.710980115668;8330.875036874331;8344.791380215544;9083.863742044006;9190.40262382943;15462.768058478907;16183;16195.43315983935;11307.604233851776;12618.17981831178;12851;12999.350032498527;13321.733565328444;12954.870451295366;13095.345232738135;13217.801732973821;13536;14324.85675143277;13608.319584020957;13807.930960345135;13875.583732488041;13975.09161904473;14471.782923255949;8221.630026648934;8365.62354694028;8557.914420855712;8846.734597962071;8926.598303076507;13095.934520327337;14062.296885155905;14116.50592229267;14161;14365.13809171453 13:44:52 INFO - 2015-12-05 13:44:52,964 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1480.8074950256478;1651.5128037229017;1722.621023374858;1745.0925518730257;1750.282384222469;7142.571445713254;7363.374113200384;7565.924340756591;7599.734009309668;7607.809804754884;7562.432817538679;7590.544567325965;7595.544267343963;7606.315431611154;7633.694652213919;2088.1334246287774;2121.66053431451;2135.636941719911;2140.957180856382;2141.186349187307;2095.3818623506027;2104.537001859596;2109.430453777487;2114.9154033838627;2148.21590119606;1724.172397249321;1760.031982409676;2036.674132138858;2088.56140210556;2112.0812446585783;2003.7996200379991;2016.9697454538193;2020.4140799168224;2023.0087257243918;2027.118203581432;2015.4558269267216;2019.3134334326253;2064.4322811226884;2066.2974588639936;2067.173130747698;7371.483996120273;7451.962740186264;7458.589777562232;7465.813354666123;7467.402607791418;4276.957230427687;4348.630366418858;4351.760653164075;4354.673399495051;4362.083962367907;2616.4505453854713;2644.087789712546;2655.827371220884;2660.4280079782748;2672.639193708844;841.8021764885247;845.4377838737294;846.3652260804397;852.3607294529103;877.2324216310728;9929.156021738161;9929.404235745878;9944.950275248577;9996.350237234556;10055.446950417723;3760.2855457462992;3787.16682329887;3789.621037896188;3872.2642697887873;3951.1110000250287;7864.174261702553;7917.643706033243;7935.325497332676;7996.04047514302;8111;4156.106437116035;4156.792160392029;4165.875023749292;4171.311733563989;4200.033992181815;3790.9431358529646;3830.9233815323537;3838.1556057667267;3842.2507611015585;3851.4607954886337;3106.1613364391937;3144.9464429416403;3153.1013661106476;3154.242981684379;3188.681131886839;937.231470194434;940.5391358234552;941.0824446164935;942.6323733743845;955.2596737528332;802.6307898366816;809.7489778168668;898.9505577193318;945.5414124149781;1007.7279134633754;6894.482913781487;7052.858942821114;7067.752628657972;7072.611006394594;7080.398166155832;508.63632502760703;509.85469141294556;540.5891522442893;545.5063167833117;686.0772261308532;5430.945690543123;5458.1266997280245;5479.726013699379;5485.424030476743;5499.422560631157;8482.618282177193;8884.333674974403;8994.145556172152;9041.367104302768;9092.454452732858;8919.955400223087;8930.955345223232;8982.146696063863;8991.190792828545;8998;6985.685644146026;6996.510244282953;7017.649117544102;7105.147382314155;7118.216996130422;6739.6967136478;6744.527883048139;6766.898496522655;6795.286494917962;6807.965960170168;7733.535987840747;7906.960465197637;7919.049714034353;7941.880871787043;8004.439689221698;8043.959780201296;8206.794830129056;8249.133840946613;8281.130481299377;8325.292350150305;6238;6283.622982621057;6315.115883776367;6382.042693595998;6405.263394709668;7040.577565346096;7120.893186602309;7153.570785752871;7173.390261827803;7223.783286501413;6573.3426657333885;6621.50338724588;6680.933190668031;6751.29111443311;6861.382475577222;5498.1752737089755;5666.206731057573;6209.65846878408;6393.104965304768;6861.348171923659;5997.820065398045;6334.524910631629;6357.205349331333;6368.9044664330995;6393.200849893763;5753.424657534213;5753.510951569164;5779.364269930388;5798.507126894261;5809.76760929575;6005.669688167192;6012.3085845126625;6053.757849685963;6077.6961151943115;6092.969535152296 13:44:52 INFO - 2015-12-05 13:44:52,965 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.74907463372483;272.94404647047344;273.24856644228373;273.95753658182963;276.5754566740052;5523.6685798852095;5565;5653.943460565393;5674.489295963368;5753.079507278836;5568.081266591008;5588.413216612258;5640.5487560995125;5642.858928526789;5645.294338207724;4052.8378864845445;4166.8749937501925;4205.222033923734;4207.969047583331;4208.074223670803;4190.329547272437;4193.433886425324;4194.4547208862805;4195.916081678364;4201.117765269297;4151.750894946298;4157.293260145767;4157.750534967897;4163.250614889319;4166.375043743447;4149.771762553059;4151.91696166078;4154.210699967011;4161.91676166478;4174.603412675791;3454.3954807908767;3556;3561.216532362876;3561.7177815986224;3563.3407819553468;5312.6281160318795;5316.840494785162;5334.893302133974;5358.142697168473;5372.194170874361;4762.880927976794;4766.73782941938;4769.809207631691;4772.618190544748;4779.665423420362;5821.79623713168;5831.88336233273;5832.88334233313;5847.502962248214;5851.561132915006;3772.679801921826;3831.750936189139;3850.8267127979307;3865.8260378283044;3877.1276462795927;6015.157877897098;6024;6050.364711705296;6066.848328791772;6085.604435711664;3876.6511014008875;3888.105735680753;3888.2612303662213;3896.7661940283674;3907.316219661605;3949.427333036751;3954.406838974177;3958.050067983663;3965.266425711253;3970.7617542947514;4644.767761611906;4646.326282688991;4647.18674232008;4649.790759415834;4657.254839225708;5674.659520428788;5854.063349864001;5881.882362352729;5884.499817515473;5891;1391.3530208453117;1411.8376386715659;1419.3754747910887;1421.3248706864363;1422.2959634980543;893.271983333581;899.5502248875562;902.5487256371814;903.0021825882436;921.6221349246777;5046.9747651261505;5100.4899510049445;5105.668131571436;5107.463716309809;5107.923381149286;6021;6036.366181550961;6080.391960803884;6092.208012958376;6109.908351374733;5130.769115389817;5153.587712982952;5170.250313704491;5172.405173405032;5182.144946083854;3282.3271229397915;3299.5215693724276;3307.6361600223954;3324.1191084362663;3327.1515763480156;5685.317761868602;5827.446392592697;5838.649681019152;5843.737031833578;5851.853703657443;6337.524685648595;6341.334159913143;6359.8092057238355;6375.458086062644;6394.104825324365;5787.045137552257;5823.126531020296;5830.766769329264;5842.357340692521;5853.619514731614;6036.33600303975;6136;6144.907826382519;6148.1699970503405;6153.969230153821;5982.282126144891;6012.428819262163;6028.065649824284;6040.486558642565;6042.637441753509;5762.481376675952;5776.277965254343;5812.3025236971835;5830.53355731532;5845.824625261249;4056.6957478188665;4098.508179018537;4104.445899803488;4110.691698122593;4112.527059388209;5886.646801191942;6070.332263450929;6077.908831367445;6078.300995385587;6089.69551522431;5826.592138550261;5850.531957443309;5855.209546711139;5863.472287494146;5878.177055212359;5845.269341332333;5854.736536855767;5863.325717542367;5864.354920958605;5869.442402971711;5574.16387541872;5709.400512946081;5790.218320526675;5792.797252096157;5798.449147330997;5966.850828729316;5967.880642387041;5974.522038236843;5988.191594134736;5988.730507127277;5603.719814009201;5726.713664316851;5734.197212390352;5772.913406298993;5790.94209057904 13:44:52 INFO - 2015-12-05 13:44:52,966 DEBUG : BROWSER_OUTPUT: |5;yui.html;702.7891632510248;801.6472751989127;801.6512816924642;803.3452736020143;809.0251247247068;11449.484773185206;11683.766324673501;11711.063114950804;11711.765764684711;11729.413529323532;10716.249862509609;13357.265350405749;13651.180929144233;13698.863011369884;13725.588232353046;786.7679034684768;797.7566842113154;800.1118758178417;805.2913436176186;822.9876551851727;797.2784629909912;800.3557136505111;801.3509057663312;804.3364224514769;805.0621026504116;826.801567623772;831.9792005199888;834.7412302186311;838.2078935406043;838.8741688746676;821.7904434369258;823.3207603726919;824.9175082491763;826.3678286111129;831.2228066757601;616.6700815063964;617.324030186949;618.2982315072425;619.0435776724926;620.4818976154916;12545.74908501834;12645.988320934302;12748.107632465732;12750.61748147557;12780.61658150257;11166.106711463064;11367.4884630191;11371;11721.589744358991;11809.173357864953;9181.954090229572;9216.170544651013;9282.953585232099;9429.858552121723;9545.331826772059;3226.9677303226904;3254.804711717281;3256.0882952773027;3264.8694052237884;3289.3750187464543;41050.794746026375;42132.57867421348;42207.36688949668;42299.78850105761;42462;9337.486438245962;9483.0516948306;9529.428234305964;9569.186619137312;9574.186194173433;16284.837151628331;16341.346346146258;16396.098214598074;16420.83579164193;16509.17454127289;6137.9079313810325;6273.153124328249;6298.433141017331;6328.525360597881;6365.777197798055;3530.858765649345;3544.113971507123;3576.910577235538;3594.2452085061905;3601.8739344123355;2703.053931124091;2713.0911144766724;2736.2748871549056;2739.1919383781833;2743.6158937748733;484.7115966000224;488.2822251290597;489.6205440783421;490.11289565885863;490.3258020222194;452.3034526828713;568.1506148308306;599.9790007349721;614.3825455417277;623.4451338308909;7298.160711518137;7441.367483763941;7525.774226773096;7575.356094732009;7696;568.1279236372231;582.3274118393178;588.888111258868;588.9381614930456;604.1360853978853;3653.634636536325;3741.962580374216;3788.6400791924725;3839.8080095995088;3859.6526312632;45849;46625.766871165426;46975.76512117486;52368;52878.73560632172;42229.57770422318;43876.780616097356;44024.779876100416;44045;46359.07281854344;41582.58417415787;41609;42102.36846447244;42287;42412;7618.69525218985;7859.371250300077;8354.289885359813;8484.91515084866;8554.91445085541;30534.38931221319;30639.693603063683;30822.69177308198;31103.68896311008;31501.212469688442;36650.633493664725;39392.80303598464;41454.37818432786;41514.58485415228;42095.1580968385;9838.212942964688;10047.598096076075;10208.795824083329;10328.793424131325;10464.843027354444;11353.205275630626;11379.146564007568;11547.884521155018;12045.397730113635;12546.498140074294;10955.780884382428;11239.494222760159;11337.03635190985;11486;11774.293542387484;11015.394153321644;11216.158788090763;11291.661250162508;11690.824637630272;11800.409979501163;10789.244752867224;10850.728731781768;10900.291481053706;11365.715857103638;11380.94309528447;9237;9586.185174260267;9633.855492167764;9639.566219520279;9882.160016398686;8390.916090839013;8499.787505312417;8614.526201058752;8640.438371505832;8989.865152022856 13:44:52 INFO - 2015-12-05 13:44:52,966 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:44:52 INFO - 2015-12-05 13:44:52,966 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: __startTimestamp1449351892955__endTimestamp 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,967 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4669.76 Median:4836.44 stddev:612.90 (12.7%) stddev-sans-first:594.55 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: Values: 2679.1 2706.8 2739.2 2745.5 2756.5 4589.4 4695.8 4792.6 4793.7 4880.1 4700.7 4728.2 4759.5 4777.7 4805.6 4398.4 4412.5 4449.7 4472.2 4510.3 507.8 4201.4 4312.5 4335.3 4452.3 4305.4 4313.5 4382.5 4399.3 4428.6 4437.5 4458.1 4475.4 4488.9 4496.5 4224.4 4324.3 4349.5 4447.7 4448.7 4681.1 4710.4 4729.8 4768.4 4823.3 5118.9 5178.7 5187.5 5199.1 5219.9 4909.0 5027.9 5041.3 5154.4 5252.1 4747.8 4801.7 4808.7 4821.4 4853.9 5291.5 5293.2 5294.9 5299.3 5299.9 4719.5 4806.8 4954.7 5021.2 5073.0 5138.4 5193.6 5196.5 5200.3 5237.3 4834.6 5120.9 5139.2 5143.8 5146.6 4906.0 4909.4 4977.4 5057.7 5062.5 3933.2 3951.6 3954.3 3955.2 3977.5 3531.8 3544.9 3563.0 3576.3 3581.6 4230.4 4268.5 4329.9 4332.9 4358.2 5217.4 5229.3 5238.3 5239.5 5243.4 4501.0 4503.1 4504.5 4516.2 4542.0 4275.7 4384.6 4426.2 4542.2 4592.5 4850.4 4855.1 4856.4 4860.4 4894.5 5117.3 5126.4 5127.6 5142.4 5183.2 4714.7 4836.4 4838.3 4840.3 4844.3 4909.6 4983.9 4987.5 4992.8 5007.3 5103.0 5108.7 5113.8 5139.0 5165.0 4674.5 4785.0 4818.3 4929.8 4950.1 4976.0 4986.1 4991.5 4996.3 5011.3 4803.7 4840.3 4840.4 4891.3 4906.9 4775.0 4877.8 4935.8 5022.8 5053.2 4819.1 4841.5 4855.9 4858.1 4889.5 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39952.28 Median:18549.45 stddev:65404.56 (352.6%) stddev-sans-first:65521.14 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: Values: 552.2 574.5 587.2 591.6 593.0 34014.8 34490.3 34585.3 34621.3 34697.1 36096.6 36651.1 36679.0 36739.0 36778.0 7847.5 7999.4 8014.8 8024.3 8049.5 7927.0 8013.9 8071.6 8072.0 8072.2 7863.2 7934.0 7973.9 8017.3 8023.6 7909.3 8019.5 8064.7 8092.5 8100.0 7816.5 7847.7 7891.3 7899.1 7915.5 36600.5 36909.6 36963.3 36965.8 37028.0 2583.3 2640.7 2640.9 2649.4 2704.6 26040.9 27224.6 27589.4 27758.6 29443.6 3306.6 3329.7 3380.1 3381.3 3408.8 224717.0 225704.0 228578.0 228730.0 228818.0 38439.6 38979.4 39050.4 56400.0 56862.1 37347.4 37391.6 37392.3 37517.1 37582.3 11421.0 11534.1 11563.1 11574.9 11590.6 9532.1 9586.4 9618.7 9706.5 9749.8 13207.9 13253.6 13294.7 13328.2 13356.1 5424.6 5555.1 5561.9 5604.3 5615.4 857.4 907.6 946.8 1053.7 1087.8 26333.6 26458.5 26725.6 26731.5 26741.5 949.0 977.8 985.2 1039.1 1046.2 13742.1 13853.5 13982.2 14055.3 14078.2 265419.0 273263.0 273617.0 274050.0 274465.0 44757.0 45119.0 45153.8 45156.3 45344.3 1174.2 1176.0 1188.4 1193.3 1197.9 25186.5 25907.6 26204.9 26233.5 26443.6 39440.0 39465.4 39535.6 39866.4 39905.4 249661.0 249849.0 251416.0 252337.0 253306.0 29319.3 29710.0 30026.0 30127.7 30134.5 38521.6 38546.0 38801.8 39627.2 39696.4 32486.0 32753.3 33045.0 33274.5 33717.7 33167.1 33195.5 33458.8 33679.0 33718.8 33136.0 33208.2 33445.0 33496.5 33614.2 28707.6 30036.0 30546.2 30748.4 30862.5 23635.9 23973.0 30633.7 32175.8 32750.8 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25034.75 Median:43374.96 stddev:76207.76 (175.7%) stddev-sans-first:76398.93 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: Values: 311.3 311.7 313.4 317.6 318.3 15152.1 15516.6 15870.8 16034.8 16640.3 14677.2 14986.3 15379.4 15545.2 15556.0 4682.2 5083.5 5085.5 5089.8 5099.8 5030.8 5086.5 5089.8 5092.8 5097.3 4811.3 4911.8 4962.4 4987.0 4996.3 4781.5 4937.4 4960.9 4978.8 4986.6 4890.2 4896.0 4925.1 4933.8 4940.2 10377.8 10475.3 10608.4 18482.7 18726.2 1684.4 1736.5 1777.5 1802.8 1803.6 8385.5 8535.4 8651.7 10736.0 12548.0 1615.5 1646.1 1683.9 1686.8 1692.5 54765.5 56488.7 56766.7 57722.4 57991.4 9505.9 9831.2 9852.1 9875.6 9884.9 12229.6 12302.4 12311.0 12397.6 12426.3 6627.1 6656.0 6665.4 6669.8 6686.1 6269.4 6289.9 6343.8 6346.0 6357.5 4084.8 4117.2 4121.9 4125.9 4148.3 1731.5 1734.6 1745.7 1749.4 1771.1 331.2 333.3 337.1 337.2 802.6 9176.3 9495.2 9597.7 9666.5 9806.7 355.2 356.1 359.3 361.1 365.7 5150.4 5151.4 5151.6 5220.1 5239.8 460376.0 461969.0 462494.0 464868.0 477981.0 70452.3 70495.0 71501.6 71695.6 72901.5 393.5 393.6 396.3 396.5 398.1 8689.2 8800.4 8883.8 8905.4 8915.9 30248.7 30807.8 31315.5 31343.8 31745.8 42800.8 43046.6 43703.3 43829.6 44477.0 7940.7 8243.4 8257.7 8330.9 8344.8 9083.9 9190.4 15462.8 16183.0 16195.4 11307.6 12618.2 12851.0 12999.4 13321.7 12954.9 13095.3 13217.8 13536.0 14324.9 13608.3 13807.9 13875.6 13975.1 14471.8 8221.6 8365.6 8557.9 8846.7 8926.6 13095.9 14062.3 14116.5 14161.0 14365.1 13:44:52 INFO - 2015-12-05 13:44:52,969 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,970 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5063.44 Median:6375.47 stddev:2723.31 (42.7%) stddev-sans-first:2717.65 13:44:52 INFO - 2015-12-05 13:44:52,971 DEBUG : BROWSER_OUTPUT: Values: 1480.8 1651.5 1722.6 1745.1 1750.3 7142.6 7363.4 7565.9 7599.7 7607.8 7562.4 7590.5 7595.5 7606.3 7633.7 2088.1 2121.7 2135.6 2141.0 2141.2 2095.4 2104.5 2109.4 2114.9 2148.2 1724.2 1760.0 2036.7 2088.6 2112.1 2003.8 2017.0 2020.4 2023.0 2027.1 2015.5 2019.3 2064.4 2066.3 2067.2 7371.5 7452.0 7458.6 7465.8 7467.4 4277.0 4348.6 4351.8 4354.7 4362.1 2616.5 2644.1 2655.8 2660.4 2672.6 841.8 845.4 846.4 852.4 877.2 9929.2 9929.4 9945.0 9996.4 10055.4 3760.3 3787.2 3789.6 3872.3 3951.1 7864.2 7917.6 7935.3 7996.0 8111.0 4156.1 4156.8 4165.9 4171.3 4200.0 3790.9 3830.9 3838.2 3842.3 3851.5 3106.2 3144.9 3153.1 3154.2 3188.7 937.2 940.5 941.1 942.6 955.3 802.6 809.7 899.0 945.5 1007.7 6894.5 7052.9 7067.8 7072.6 7080.4 508.6 509.9 540.6 545.5 686.1 5430.9 5458.1 5479.7 5485.4 5499.4 8482.6 8884.3 8994.1 9041.4 9092.5 8920.0 8931.0 8982.1 8991.2 8998.0 6985.7 6996.5 7017.6 7105.1 7118.2 6739.7 6744.5 6766.9 6795.3 6808.0 7733.5 7907.0 7919.0 7941.9 8004.4 8044.0 8206.8 8249.1 8281.1 8325.3 6238.0 6283.6 6315.1 6382.0 6405.3 7040.6 7120.9 7153.6 7173.4 7223.8 6573.3 6621.5 6680.9 6751.3 6861.4 5498.2 5666.2 6209.7 6393.1 6861.3 5997.8 6334.5 6357.2 6368.9 6393.2 5753.4 5753.5 5779.4 5798.5 5809.8 6005.7 6012.3 6053.8 6077.7 6093.0 13:44:52 INFO - 2015-12-05 13:44:52,971 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,971 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4808.34 Median:5622.13 stddev:1480.04 (26.3%) stddev-sans-first:1444.34 13:44:52 INFO - 2015-12-05 13:44:52,971 DEBUG : BROWSER_OUTPUT: Values: 262.7 272.9 273.2 274.0 276.6 5523.7 5565.0 5653.9 5674.5 5753.1 5568.1 5588.4 5640.5 5642.9 5645.3 4052.8 4166.9 4205.2 4208.0 4208.1 4190.3 4193.4 4194.5 4195.9 4201.1 4151.8 4157.3 4157.8 4163.3 4166.4 4149.8 4151.9 4154.2 4161.9 4174.6 3454.4 3556.0 3561.2 3561.7 3563.3 5312.6 5316.8 5334.9 5358.1 5372.2 4762.9 4766.7 4769.8 4772.6 4779.7 5821.8 5831.9 5832.9 5847.5 5851.6 3772.7 3831.8 3850.8 3865.8 3877.1 6015.2 6024.0 6050.4 6066.8 6085.6 3876.7 3888.1 3888.3 3896.8 3907.3 3949.4 3954.4 3958.1 3965.3 3970.8 4644.8 4646.3 4647.2 4649.8 4657.3 5674.7 5854.1 5881.9 5884.5 5891.0 1391.4 1411.8 1419.4 1421.3 1422.3 893.3 899.6 902.5 903.0 921.6 5047.0 5100.5 5105.7 5107.5 5107.9 6021.0 6036.4 6080.4 6092.2 6109.9 5130.8 5153.6 5170.3 5172.4 5182.1 3282.3 3299.5 3307.6 3324.1 3327.2 5685.3 5827.4 5838.6 5843.7 5851.9 6337.5 6341.3 6359.8 6375.5 6394.1 5787.0 5823.1 5830.8 5842.4 5853.6 6036.3 6136.0 6144.9 6148.2 6154.0 5982.3 6012.4 6028.1 6040.5 6042.6 5762.5 5776.3 5812.3 5830.5 5845.8 4056.7 4098.5 4104.4 4110.7 4112.5 5886.6 6070.3 6077.9 6078.3 6089.7 5826.6 5850.5 5855.2 5863.5 5878.2 5845.3 5854.7 5863.3 5864.4 5869.4 5574.2 5709.4 5790.2 5792.8 5798.4 5966.9 5967.9 5974.5 5988.2 5988.7 5603.7 5726.7 5734.2 5772.9 5790.9 13:44:52 INFO - 2015-12-05 13:44:52,971 DEBUG : BROWSER_OUTPUT: 13:44:52 INFO - 2015-12-05 13:44:52,972 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12441.86 Median:43950.78 stddev:13919.82 (31.7%) stddev-sans-first:13930.95 13:44:52 INFO - 2015-12-05 13:44:52,972 DEBUG : BROWSER_OUTPUT: Values: 702.8 801.6 801.7 803.3 809.0 11449.5 11683.8 11711.1 11711.8 11729.4 10716.2 13357.3 13651.2 13698.9 13725.6 786.8 797.8 800.1 805.3 823.0 797.3 800.4 801.4 804.3 805.1 826.8 832.0 834.7 838.2 838.9 821.8 823.3 824.9 826.4 831.2 616.7 617.3 618.3 619.0 620.5 12545.7 12646.0 12748.1 12750.6 12780.6 11166.1 11367.5 11371.0 11721.6 11809.2 9182.0 9216.2 9283.0 9429.9 9545.3 3227.0 3254.8 3256.1 3264.9 3289.4 41050.8 42132.6 42207.4 42299.8 42462.0 9337.5 9483.1 9529.4 9569.2 9574.2 16284.8 16341.3 16396.1 16420.8 16509.2 6137.9 6273.2 6298.4 6328.5 6365.8 3530.9 3544.1 3576.9 3594.2 3601.9 2703.1 2713.1 2736.3 2739.2 2743.6 484.7 488.3 489.6 490.1 490.3 452.3 568.2 600.0 614.4 623.4 7298.2 7441.4 7525.8 7575.4 7696.0 568.1 582.3 588.9 588.9 604.1 3653.6 3742.0 3788.6 3839.8 3859.7 45849.0 46625.8 46975.8 52368.0 52878.7 42229.6 43876.8 44024.8 44045.0 46359.1 41582.6 41609.0 42102.4 42287.0 42412.0 7618.7 7859.4 8354.3 8484.9 8554.9 30534.4 30639.7 30822.7 31103.7 31501.2 36650.6 39392.8 41454.4 41514.6 42095.2 9838.2 10047.6 10208.8 10328.8 10464.8 11353.2 11379.1 11547.9 12045.4 12546.5 10955.8 11239.5 11337.0 11486.0 11774.3 11015.4 11216.2 11291.7 11690.8 11800.4 10789.2 10850.7 10900.3 11365.7 11380.9 9237.0 9586.2 9633.9 9639.6 9882.2 8390.9 8499.8 8614.5 8640.4 8989.9 13:44:52 INFO - 2015-12-05 13:44:52,972 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:44:52 INFO - 2015-12-05 13:44:52,973 DEBUG : BROWSER_OUTPUT: 13:44:53 INFO - 2015-12-05 13:44:53,705 INFO : Browser exited with error code: 0 13:44:53 INFO - 2015-12-05 13:44:53,728 INFO : Completed test dromaeo_css (00:18:35) 13:44:53 INFO - 2015-12-05 13:44:53,728 INFO : Starting test kraken 13:44:53 INFO - 2015-12-05 13:44:53,729 DEBUG : operating with platform_type : linux_ 13:44:53 INFO - 2015-12-05 13:44:53,729 INFO : Initialising browser for kraken test... 13:44:53 INFO - 2015-12-05 13:44:53,735 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iydr9/profile http://localhost:55611/getInfo.html 13:44:58 INFO - 2015-12-05 13:44:58,784 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:44:58 INFO - 2015-12-05 13:44:58,784 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:44:58 INFO - 2015-12-05 13:44:58,785 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:44:58 INFO - 2015-12-05 13:44:58,785 DEBUG : BROWSER_OUTPUT: __metrics 13:44:58 INFO - 2015-12-05 13:44:58,934 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] 13:44:59 INFO - 2015-12-05 13:44:59,877 INFO : Browser initialized. 13:44:59 INFO - 2015-12-05 13:44:59,877 INFO : Running cycle 1/1 for kraken test... 13:44:59 INFO - 2015-12-05 13:44:59,877 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iydr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:45:11 INFO - 2015-12-05 13:45:11,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 13:45:11 INFO - 2015-12-05 13:45:11,908 DEBUG : BROWSER_OUTPUT: 13:45:14 INFO - 2015-12-05 13:45:14,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:15 INFO - 2015-12-05 13:45:15,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 143806464 13:45:15 INFO - 2015-12-05 13:45:15,103 DEBUG : BROWSER_OUTPUT: 13:45:17 INFO - 2015-12-05 13:45:17,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-dft) 13:45:18 INFO - 2015-12-05 13:45:18,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 144084992 13:45:18 INFO - 2015-12-05 13:45:18,431 DEBUG : BROWSER_OUTPUT: 13:45:21 INFO - 2015-12-05 13:45:21,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-fft) 13:45:21 INFO - 2015-12-05 13:45:21,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 137576448 13:45:21 INFO - 2015-12-05 13:45:21,911 DEBUG : BROWSER_OUTPUT: 13:45:24 INFO - 2015-12-05 13:45:24,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-oscillator) 13:45:24 INFO - 2015-12-05 13:45:24,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 13:45:24 INFO - 2015-12-05 13:45:24,681 DEBUG : BROWSER_OUTPUT: 13:45:26 INFO - 2015-12-05 13:45:26,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:27 INFO - 2015-12-05 13:45:27,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 139956224 13:45:27 INFO - 2015-12-05 13:45:27,481 DEBUG : BROWSER_OUTPUT: 13:45:30 INFO - 2015-12-05 13:45:30,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:31 INFO - 2015-12-05 13:45:31,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 13:45:31 INFO - 2015-12-05 13:45:31,135 DEBUG : BROWSER_OUTPUT: 13:45:34 INFO - 2015-12-05 13:45:34,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:35 INFO - 2015-12-05 13:45:35,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 138723328 13:45:35 INFO - 2015-12-05 13:45:35,251 DEBUG : BROWSER_OUTPUT: 13:45:38 INFO - 2015-12-05 13:45:38,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55611/tests/kraken/driver.html?testName=json-parse-financial) 13:45:38 INFO - 2015-12-05 13:45:38,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 13:45:38 INFO - 2015-12-05 13:45:38,766 DEBUG : BROWSER_OUTPUT: 13:45:40 INFO - 2015-12-05 13:45:40,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:41 INFO - 2015-12-05 13:45:41,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 13:45:41 INFO - 2015-12-05 13:45:41,126 DEBUG : BROWSER_OUTPUT: 13:45:43 INFO - 2015-12-05 13:45:43,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:43 INFO - 2015-12-05 13:45:43,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 13:45:43 INFO - 2015-12-05 13:45:43,646 DEBUG : BROWSER_OUTPUT: 13:45:45 INFO - 2015-12-05 13:45:45,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:46 INFO - 2015-12-05 13:45:46,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 13:45:46 INFO - 2015-12-05 13:45:46,424 DEBUG : BROWSER_OUTPUT: 13:45:49 INFO - 2015-12-05 13:45:49,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:45:49 INFO - 2015-12-05 13:45:49,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 140500992 13:45:49 INFO - 2015-12-05 13:45:49,626 DEBUG : BROWSER_OUTPUT: 13:45:52 INFO - 2015-12-05 13:45:52,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:45:52 INFO - 2015-12-05 13:45:52,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 13:45:52 INFO - 2015-12-05 13:45:52,820 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55611/tests/kraken/driver.html?testName=ai-astar) 13:45:54 INFO - 2015-12-05 13:45:54,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 140652544 13:45:54 INFO - 2015-12-05 13:45:54,840 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,843 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:45:54 INFO - 2015-12-05 13:45:54,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:45:54 INFO - 2015-12-05 13:45:54,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:45:54 INFO - 2015-12-05 13:45:54,843 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:45:54 INFO - 2015-12-05 13:45:54,843 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;112;113;111;126;111;111;112;113 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;154;180;135;152;156;135;174;130 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;161;164;162;166;170;163;164;163 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;75;74;72;131;79;80;78;75 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;128;95;93;94;130;95;94;130 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;109;110;114;111;109;110 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;152;151;148;148;147;148;148;149;150 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;95;96;96;96;96;97;97 13:45:54 INFO - 2015-12-05 13:45:54,844 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;74;72;73;73;72;72;73;71 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;69;68;69;68;69;69;69 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;86;87;87;85;86;85;95;86;87 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;125;131;122;127;126;124;128;126;128 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;144;148;145;152;146;141;143;146;133 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;69;70;71;76;72;71;70;69 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:45:54 INFO - 2015-12-05 13:45:54,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 13:45:54 INFO - 2015-12-05 13:45:54,846 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:45:54 INFO - 2015-12-05 13:45:54,846 DEBUG : BROWSER_OUTPUT: __startTimestamp1449351954842__endTimestamp 13:45:54 INFO - 2015-12-05 13:45:54,846 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,853 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:112.50 stddev:4.82 (4.3%) stddev-sans-first:5.10 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 112.0 113.0 111.0 126.0 111.0 111.0 112.0 113.0 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:154.00 stddev:17.76 (11.5%) stddev-sans-first:18.78 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 154.0 180.0 135.0 152.0 156.0 135.0 174.0 130.0 13:45:54 INFO - 2015-12-05 13:45:54,854 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.51 (1.5%) stddev-sans-first:2.64 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 161.0 164.0 162.0 166.0 170.0 163.0 164.0 163.0 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:17.73 (23.6%) stddev-sans-first:18.62 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 75.0 74.0 72.0 131.0 79.0 80.0 78.0 75.0 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:16.95 (18.0%) stddev-sans-first:17.52 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 128.0 95.0 93.0 94.0 130.0 95.0 94.0 130.0 13:45:54 INFO - 2015-12-05 13:45:54,855 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 109.0 110.0 114.0 111.0 109.0 110.0 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.69 (1.1%) stddev-sans-first:1.66 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: Values: 147.0 152.0 151.0 148.0 148.0 147.0 148.0 148.0 149.0 150.0 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 97.0 97.0 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.00 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 74.0 72.0 73.0 73.0 72.0 72.0 73.0 71.0 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 69.0 68.0 69.0 68.0 69.0 69.0 69.0 13:45:54 INFO - 2015-12-05 13:45:54,856 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:3.61 (4.2%) stddev-sans-first:3.06 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: Values: 94.0 86.0 87.0 87.0 85.0 86.0 85.0 95.0 86.0 87.0 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.50 stddev:2.67 (2.1%) stddev-sans-first:2.60 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: Values: 123.0 125.0 131.0 122.0 127.0 126.0 124.0 128.0 126.0 128.0 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:146.00 stddev:5.38 (3.7%) stddev-sans-first:5.24 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: Values: 151.0 144.0 148.0 145.0 152.0 146.0 141.0 143.0 146.0 133.0 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:2.13 (3.0%) stddev-sans-first:2.22 13:45:54 INFO - 2015-12-05 13:45:54,857 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 69.0 70.0 71.0 76.0 72.0 71.0 70.0 69.0 13:45:54 INFO - 2015-12-05 13:45:54,858 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:45:54 INFO - 2015-12-05 13:45:54,858 DEBUG : BROWSER_OUTPUT: 13:45:55 INFO - 2015-12-05 13:45:55,737 INFO : Browser exited with error code: 0 13:45:55 INFO - 2015-12-05 13:45:55,787 INFO : Completed test kraken (00:01:02) 13:45:55 INFO - 2015-12-05 13:45:55,787 INFO : Starting test v8_7 13:45:55 INFO - 2015-12-05 13:45:55,788 DEBUG : operating with platform_type : linux_ 13:45:55 INFO - 2015-12-05 13:45:55,788 INFO : Initialising browser for v8_7 test... 13:45:55 INFO - 2015-12-05 13:45:55,794 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuhdb6/profile http://localhost:55611/getInfo.html 13:46:00 INFO - 2015-12-05 13:46:00,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:46:00 INFO - 2015-12-05 13:46:00,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:46:00 INFO - 2015-12-05 13:46:00,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:46:00 INFO - 2015-12-05 13:46:00,747 DEBUG : BROWSER_OUTPUT: __metrics 13:46:00 INFO - 2015-12-05 13:46:00,876 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] 13:46:01 INFO - 2015-12-05 13:46:01,765 INFO : Browser initialized. 13:46:01 INFO - 2015-12-05 13:46:01,765 INFO : Running cycle 1/1 for v8_7 test... 13:46:01 INFO - 2015-12-05 13:46:01,765 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuhdb6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:46:13 INFO - 2015-12-05 13:46:13,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 143433728 13:46:13 INFO - 2015-12-05 13:46:13,797 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55611/tests/v8_7/run.html (next: http://localhost:55611/tests/v8_7/run.html) 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:46:35 INFO - 2015-12-05 13:46:35,560 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |0;Richards;168.0672268907563 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.1620626151013 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.1618625277162 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1078.7486515641856 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |5;Earley;707.7140835102618 13:46:35 INFO - 2015-12-05 13:46:35,561 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 13:46:35 INFO - 2015-12-05 13:46:35,562 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 13:46:35 INFO - 2015-12-05 13:46:35,562 DEBUG : BROWSER_OUTPUT: |8;Splay;605.3268765133172 13:46:35 INFO - 2015-12-05 13:46:35,562 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:46:35 INFO - 2015-12-05 13:46:35,562 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:46:35 INFO - 2015-12-05 13:46:35,562 DEBUG : BROWSER_OUTPUT: __startTimestamp1449351995559__endTimestamp 13:46:35 INFO - 2015-12-05 13:46:35,563 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,563 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:46:35 INFO - 2015-12-05 13:46:35,563 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:46:35 INFO - 2015-12-05 13:46:35,563 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.07 Median:168.07 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: Values: 168.1 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.16 Median:184.16 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: Values: 184.2 13:46:35 INFO - 2015-12-05 13:46:35,564 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.16 Median:277.16 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: Values: 277.2 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: Values: 5170.1 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: Values: 1078.7 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:707.71 Median:707.71 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: Values: 707.7 13:46:35 INFO - 2015-12-05 13:46:35,565 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: Values: 12047.6 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: Values: 25666.7 13:46:35 INFO - 2015-12-05 13:46:35,566 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,567 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,567 DEBUG : BROWSER_OUTPUT: Values: 605.3 13:46:35 INFO - 2015-12-05 13:46:35,567 DEBUG : BROWSER_OUTPUT: 13:46:35 INFO - 2015-12-05 13:46:35,567 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:46:35 INFO - 2015-12-05 13:46:35,567 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:46:35 INFO - 2015-12-05 13:46:35,568 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:46:35 INFO - 2015-12-05 13:46:35,568 DEBUG : BROWSER_OUTPUT: 13:46:36 INFO - 2015-12-05 13:46:36,457 INFO : Browser exited with error code: 0 13:46:36 INFO - 2015-12-05 13:46:36,475 INFO : Completed test v8_7 (00:00:40) 13:46:36 INFO - 2015-12-05 13:46:36,539 INFO : Completed test suite (00:20:18) 13:46:36 INFO - 2015-12-05 13:46:36,539 DEBUG : Working with test: dromaeo_css 13:46:36 INFO - 2015-12-05 13:46:36,539 DEBUG : Generating results file: dromaeo_css 13:46:36 INFO - 2015-12-05 13:46:36,540 DEBUG : Working with test: kraken 13:46:36 INFO - 2015-12-05 13:46:36,540 DEBUG : Generating results file: kraken 13:46:36 INFO - 2015-12-05 13:46:36,541 INFO : javascript benchmark 13:46:36 INFO - 2015-12-05 13:46:36,541 DEBUG : Working with test: v8_7 13:46:36 INFO - 2015-12-05 13:46:36,541 DEBUG : Generating results file: v8_7 13:46:36 INFO - 2015-12-05 13:46:36,541 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:46:36 INFO - 2015-12-05 13:46:36,594 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:46:36 INFO - 2015-12-05 13:46:36,594 DEBUG : process_Request line: dromaeo_css 6162.72 graph.html#tests=[[72,132,43]] 13:46:36 INFO - 2015-12-05 13:46:36,594 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:46:36 INFO - 2015-12-05 13:46:36,628 DEBUG : process_Request line: kraken 1539.10 graph.html#tests=[[232,132,43]] 13:46:36 INFO - 2015-12-05 13:46:36,628 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:46:36 INFO - 2015-12-05 13:46:36,661 DEBUG : process_Request line: v8_7 21422.69 graph.html#tests=[[230,132,43]] 13:46:36 INFO - 2015-12-05 13:46:36,663 INFO : javascript benchmark 13:46:36 INFO - 2015-12-05 13:46:36,667 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.062328185135, 2706.8105232633725, 2739.2330147558678, 2745.5469847475156, 2756.4624898144857, 4589.380433641466, 4695.765211739408, 4792.6405519586, 4793.736344501055, 4880.097182021324, 4700.670953033289, 4728.1962066448705, 4759.452662943762, 4777.665563410563, 4805.61555075594, 4398.406215160952, 4412.514623391425, 4449.66627502937, 4472.150291444631, 4510.278355463127, 507.8182827210583, 4201.369794530814, 4312.482502099737, 4335.284678028137, 4452.265376212921, 4305.440292761952, 4313.547077556858, 4382.452193475816, 4399.274119770234, 4428.601425871687, 4437.511873693891, 4458.108378324348, 4475.440569928759, 4488.8877778055485, 4496.482904465963, 4224.366345048236, 4324.264874971231, 4349.478062632473, 4447.666425018137, 4448.733076015449, 4681.133990211822, 4710.4347478302825, 4729.787159577827, 4768.356271903318, 4823.348847905558, 5118.872028199287, 5178.689278643294, 5187.48125187482, 5199.064168449678, 5219.947800522022, 4909.042736666352, 5027.949720502821, 5041.344625198737, 5154.38147422308, 5252.1071417858675, 4747.8100875965265, 4801.663883528155, 4808.663393562487, 4821.37322148122, 4853.854384368475, 5291.523762861284, 5293.153095504701, 5294.894102117936, 5299.2845965794895, 5299.894002120013, 4719.528047195322, 4806.7836947337455, 4954.677945933503, 5021.196608542616, 5072.974635126875, 5138.38339399267, 5193.584513238932, 5196.480351964773, 5200.2979597754575, 5237.3453318335205, 4834.589059929875, 5120.871978200575, 5139.152039913447, 5143.8456846294675, 5146.588272938156, 4905.9754701226975, 4909.410870695468, 4977.377827771528, 5057.721825299644, 5062.493750624908, 3933.2330195612153, 3951.604839516083, 3954.2882281189663, 3955.228730397545, 3977.482927219443, 3531.7527773056154, 3544.8936531904083, 3563.037979745506, 3576.284743051348, 3581.552305961755, 4230.386593943923, 4268.466441694788, 4329.935050974238, 4332.870013899588, 4358.171947329997, 5217.373915130209, 5229.267902493654, 5238.3190185276435, 5239.476052394806, 5243.4232234454175, 4501.032278060233, 4503.121891231244, 4504.549545045535, 4516.209663308908, 4541.9545804542195, 4275.743455392624, 4384.6273066789045, 4426.15902978433, 4542.205114105019, 4592.494825569184, 4850.442199147144, 4855.053264613366, 4856.417229932431, 4860.441049279308, 4894.51054894522, 5117.257997590403, 5126.384833819965, 5127.6410651254055, 5142.434332223527, 5183.196604526304, 4714.740689262124, 4836.443808962014, 4838.322634831056, 4840.29815676732, 4844.297576851266, 4909.607231421549, 4983.8504844854715, 4987.451380348086, 4992.800287988585, 5007.349044624176, 5103.030424219386, 5108.7445627717725, 5113.846584602468, 5139.023585518739, 5164.9741751291, 4674.462436819673, 4784.952150478451, 4818.325434439112, 4929.778159982738, 4950.059488697136, 4976.029674213493, 4986.077575648516, 4991.47589503097, 4996.275540046746, 5011.348524691767, 4803.663743537919, 4840.29815676732, 4840.443349014768, 4891.29076283944, 4906.852794416173, 4774.976125119352, 4877.804937790264, 4935.8025678972435, 5022.84931452057, 5053.191489361684, 4819.132556139928, 4841.467438581823, 4855.927161092516, 4858.12553740316, 4889.535494128052], "unit": "ms", "name": "dojo.html", "value": 4631.627368664803}, {"lowerIsBetter": false, "replicates": [552.1711445433896, 574.4944448884982, 587.2072701852497, 591.6213623281101, 593.0067137544614, 34014.82992585037, 34490.31019379611, 34585.30829383411, 34621.30757384854, 34697.13257168569, 36096.63903360966, 36651.083722906944, 36679.0, 36739.0, 36778.0, 7847.4506784524965, 7999.440039197259, 8014.799630009267, 8024.317932975675, 8049.51702897828, 7927.0, 8013.919860801405, 8071.556064416454, 8072.0, 8072.19278072194, 7863.174366691473, 7934.047914250298, 7973.920260797405, 8017.278444939954, 8023.598820059003, 7909.288164065233, 8019.5188288702575, 8064.677412903536, 8092.514449133071, 8100.0, 7816.452848300622, 7847.725329613436, 7891.289783919475, 7899.131095579482, 7915.485493442908, 36600.45099323512, 36909.630903690886, 36963.26073478542, 36965.815170923976, 37028.0, 2583.32833463299, 2640.749128832758, 2640.854752988585, 2649.443616840466, 2704.580789977537, 26040.86979565109, 27224.59163112555, 27589.448211035866, 27758.583621245696, 29443.558346624817, 3306.6197387300285, 3329.667033296675, 3380.070480617825, 3381.2730262993573, 3408.7613867029318, 224717.0, 225704.0, 228578.0, 228730.0, 228818.0, 38439.61560384416, 38979.41530877039, 39050.41424378636, 56400.0, 56862.147067794016, 37347.43978840319, 37391.62608373936, 37392.25215495675, 37517.06207344838, 37582.30879610424, 11421.0, 11534.134939879543, 11563.074954003827, 11574.942125289319, 11590.594329198437, 9532.142107210384, 9586.424814511152, 9618.663346782829, 9706.5146742664, 9749.756256093513, 13207.933960330136, 13253.602391928258, 13294.734105317839, 13328.200307981358, 13356.131851429625, 5424.5660347172925, 5555.083411237181, 5561.940932487116, 5604.271444712243, 5615.382307946123, 857.3655494933704, 907.6369452219166, 946.786972931085, 1053.6996955867694, 1087.842262871895, 26333.604995925078, 26458.46346033729, 26725.599116013276, 26731.465370692476, 26741.465170696476, 948.9893263674303, 977.8142152990908, 985.2019863910256, 1039.0544604409952, 1046.1735229169024, 13742.106763060368, 13853.51512697071, 13982.230977296347, 14055.297235138201, 14078.225697586526, 265419.0, 273263.0, 273617.0, 274050.0, 274465.0, 44757.0, 45119.0, 45153.774231128635, 45156.3226551602, 45344.3198352025, 1174.17220859294, 1175.9764804703857, 1188.4057971014493, 1193.2840295822612, 1197.9341136237417, 25186.496270074862, 25907.611385829605, 26204.868975655, 26233.475330493664, 26443.603345949443, 39440.0, 39465.40801888031, 39535.60464395319, 39866.402003969386, 39905.40141897816, 249661.0, 249849.0, 251416.0, 252337.0, 253306.0, 29319.267018324714, 29710.0, 30026.0, 30127.69872301249, 30134.547981780728, 38521.61478385292, 38546.0, 38801.805990969864, 39627.20745585015, 39696.40455393229, 32486.0, 32753.34493310073, 33045.0, 33274.500882486296, 33717.66282337243, 33167.109598176095, 33195.50206746949, 33458.832705836314, 33679.0, 33718.831405842815, 33136.0, 33208.1697957553, 33444.99665010053, 33496.49755253722, 33614.159646009044, 28707.569386459636, 30036.0, 30546.236344091576, 30748.38638715734, 30862.53706194364, 23635.88182059079, 23973.0, 30633.693663063084, 32175.839120804245, 32750.836245818617], "unit": "ms", "name": "ext.html", "value": 16198.90767816032}, {"lowerIsBetter": false, "replicates": [311.3166599314505, 311.6836411042792, 313.3998393077257, 317.61251273446385, 318.3235624298365, 15152.09087454752, 15516.612084697874, 15870.761938570931, 16034.83965160348, 16640.33438662452, 14677.192754398504, 14986.325615347308, 15379.38482460703, 15545.222738863069, 15556.0, 4682.180618391776, 5083.491650834905, 5085.491450854922, 5089.847304580869, 5099.796008159669, 5030.84907452777, 5086.516780905827, 5089.847304580869, 5092.770825312869, 5097.3118628984985, 4811.254255590372, 4911.803527858881, 4962.429320628138, 4986.975065124688, 4996.32549605804, 4781.474037855833, 4937.432195297533, 4960.925586116211, 4978.751062446863, 4986.5761410280165, 4890.24201248807, 4895.996320754237, 4925.113479573675, 4933.827316043958, 4940.209566469383, 10377.79244415115, 10475.27158018926, 10608.416537090457, 18482.722759158623, 18726.157322920502, 1684.3515246630136, 1736.4530172995592, 1777.5200695812186, 1802.8107048759823, 1803.603207294393, 8385.454945428528, 8535.359848011423, 8651.6971905983, 10736.0, 12548.0, 1615.4622818404675, 1646.0617448054613, 1683.9494815155565, 1686.7891513560805, 1692.4753326468833, 54765.452345476835, 56488.71755641237, 56766.71616641932, 57722.422775772124, 57991.42008579902, 9505.857412138823, 9831.213502919893, 9852.113309802153, 9875.604975800887, 9884.901150988399, 12229.571964981184, 12302.446389912475, 12311.0, 12397.566085186974, 12426.254424734545, 6627.105340778933, 6656.0, 6665.400113989765, 6669.799906002828, 6686.130802995676, 6269.435750782361, 6289.937100628935, 6343.777967771106, 6345.96827015862, 6357.523185761086, 4084.81618327176, 4117.197146556453, 4121.855735049259, 4125.91748165035, 4148.274052040881, 1731.4805558332703, 1734.5689805910174, 1745.65086982604, 1749.4401791426876, 1771.079038899765, 331.2048696067273, 333.32002714462226, 337.0814530404677, 337.2193372343018, 802.626778547978, 9176.31177661678, 9495.240380769523, 9597.712068637951, 9666.516674166263, 9806.705798826046, 355.2043422733111, 356.12571137856503, 359.31550396494197, 361.14769144818206, 365.6508034826734, 5150.40770311419, 5151.356080489939, 5151.562117220078, 5220.060389129993, 5239.790408383622, 460376.0, 461969.0, 462494.0, 464868.0, 477981.0, 70452.29547704458, 70495.0, 71501.6424917872, 71695.64152179206, 72901.54196916138, 393.4845352588119, 393.55528253074414, 396.32426712455197, 396.488529796565, 398.1280994621769, 8689.17452841979, 8800.427972181787, 8883.777905552155, 8905.376623636283, 8915.910840891507, 30248.69751302547, 30807.845960770053, 31315.53026704647, 31343.84328078345, 31745.8412707935, 42800.78599606982, 43046.56953430551, 43703.34444983264, 43829.56170438255, 44477.0, 7940.682372705027, 8243.422960392714, 8257.710980115668, 8330.875036874331, 8344.791380215544, 9083.863742044006, 9190.40262382943, 15462.768058478907, 16183.0, 16195.43315983935, 11307.604233851776, 12618.17981831178, 12851.0, 12999.350032498527, 13321.733565328444, 12954.870451295366, 13095.345232738135, 13217.801732973821, 13536.0, 14324.85675143277, 13608.319584020957, 13807.930960345135, 13875.583732488041, 13975.09161904473, 14471.782923255949, 8221.630026648934, 8365.62354694028, 8557.914420855712, 8846.734597962071, 8926.598303076507, 13095.934520327337, 14062.296885155905, 14116.50592229267, 14161.0, 14365.13809171453], "unit": "ms", "name": "jquery.html", "value": 7192.414512002009}, {"lowerIsBetter": false, "replicates": [1480.8074950256478, 1651.5128037229017, 1722.621023374858, 1745.0925518730257, 1750.282384222469, 7142.571445713254, 7363.374113200384, 7565.924340756591, 7599.734009309668, 7607.809804754884, 7562.432817538679, 7590.544567325965, 7595.544267343963, 7606.315431611154, 7633.694652213919, 2088.1334246287774, 2121.66053431451, 2135.636941719911, 2140.957180856382, 2141.186349187307, 2095.3818623506027, 2104.537001859596, 2109.430453777487, 2114.9154033838627, 2148.21590119606, 1724.172397249321, 1760.031982409676, 2036.674132138858, 2088.56140210556, 2112.0812446585783, 2003.7996200379991, 2016.9697454538193, 2020.4140799168224, 2023.0087257243918, 2027.118203581432, 2015.4558269267216, 2019.3134334326253, 2064.4322811226884, 2066.2974588639936, 2067.173130747698, 7371.483996120273, 7451.962740186264, 7458.589777562232, 7465.813354666123, 7467.402607791418, 4276.957230427687, 4348.630366418858, 4351.760653164075, 4354.673399495051, 4362.083962367907, 2616.4505453854713, 2644.087789712546, 2655.827371220884, 2660.4280079782748, 2672.639193708844, 841.8021764885247, 845.4377838737294, 846.3652260804397, 852.3607294529103, 877.2324216310728, 9929.156021738161, 9929.404235745878, 9944.950275248577, 9996.350237234556, 10055.446950417723, 3760.2855457462992, 3787.16682329887, 3789.621037896188, 3872.2642697887873, 3951.1110000250287, 7864.174261702553, 7917.643706033243, 7935.325497332676, 7996.04047514302, 8111.0, 4156.106437116035, 4156.792160392029, 4165.875023749292, 4171.311733563989, 4200.033992181815, 3790.9431358529646, 3830.9233815323537, 3838.1556057667267, 3842.2507611015585, 3851.4607954886337, 3106.1613364391937, 3144.9464429416403, 3153.1013661106476, 3154.242981684379, 3188.681131886839, 937.231470194434, 940.5391358234552, 941.0824446164935, 942.6323733743845, 955.2596737528332, 802.6307898366816, 809.7489778168668, 898.9505577193318, 945.5414124149781, 1007.7279134633754, 6894.482913781487, 7052.858942821114, 7067.752628657972, 7072.611006394594, 7080.398166155832, 508.63632502760703, 509.85469141294556, 540.5891522442893, 545.5063167833117, 686.0772261308532, 5430.945690543123, 5458.1266997280245, 5479.726013699379, 5485.424030476743, 5499.422560631157, 8482.618282177193, 8884.333674974403, 8994.145556172152, 9041.367104302768, 9092.454452732858, 8919.955400223087, 8930.955345223232, 8982.146696063863, 8991.190792828545, 8998.0, 6985.685644146026, 6996.510244282953, 7017.649117544102, 7105.147382314155, 7118.216996130422, 6739.6967136478, 6744.527883048139, 6766.898496522655, 6795.286494917962, 6807.965960170168, 7733.535987840747, 7906.960465197637, 7919.049714034353, 7941.880871787043, 8004.439689221698, 8043.959780201296, 8206.794830129056, 8249.133840946613, 8281.130481299377, 8325.292350150305, 6238.0, 6283.622982621057, 6315.115883776367, 6382.042693595998, 6405.263394709668, 7040.577565346096, 7120.893186602309, 7153.570785752871, 7173.390261827803, 7223.783286501413, 6573.3426657333885, 6621.50338724588, 6680.933190668031, 6751.29111443311, 6861.382475577222, 5498.1752737089755, 5666.206731057573, 6209.65846878408, 6393.104965304768, 6861.348171923659, 5997.820065398045, 6334.524910631629, 6357.205349331333, 6368.9044664330995, 6393.200849893763, 5753.424657534213, 5753.510951569164, 5779.364269930388, 5798.507126894261, 5809.76760929575, 6005.669688167192, 6012.3085845126625, 6053.757849685963, 6077.6961151943115, 6092.969535152296], "unit": "ms", "name": "mootools.html", "value": 4043.611488118985}, {"lowerIsBetter": false, "replicates": [262.74907463372483, 272.94404647047344, 273.24856644228373, 273.95753658182963, 276.5754566740052, 5523.6685798852095, 5565.0, 5653.943460565393, 5674.489295963368, 5753.079507278836, 5568.081266591008, 5588.413216612258, 5640.5487560995125, 5642.858928526789, 5645.294338207724, 4052.8378864845445, 4166.8749937501925, 4205.222033923734, 4207.969047583331, 4208.074223670803, 4190.329547272437, 4193.433886425324, 4194.4547208862805, 4195.916081678364, 4201.117765269297, 4151.750894946298, 4157.293260145767, 4157.750534967897, 4163.250614889319, 4166.375043743447, 4149.771762553059, 4151.91696166078, 4154.210699967011, 4161.91676166478, 4174.603412675791, 3454.3954807908767, 3556.0, 3561.216532362876, 3561.7177815986224, 3563.3407819553468, 5312.6281160318795, 5316.840494785162, 5334.893302133974, 5358.142697168473, 5372.194170874361, 4762.880927976794, 4766.73782941938, 4769.809207631691, 4772.618190544748, 4779.665423420362, 5821.79623713168, 5831.88336233273, 5832.88334233313, 5847.502962248214, 5851.561132915006, 3772.679801921826, 3831.750936189139, 3850.8267127979307, 3865.8260378283044, 3877.1276462795927, 6015.157877897098, 6024.0, 6050.364711705296, 6066.848328791772, 6085.604435711664, 3876.6511014008875, 3888.105735680753, 3888.2612303662213, 3896.7661940283674, 3907.316219661605, 3949.427333036751, 3954.406838974177, 3958.050067983663, 3965.266425711253, 3970.7617542947514, 4644.767761611906, 4646.326282688991, 4647.18674232008, 4649.790759415834, 4657.254839225708, 5674.659520428788, 5854.063349864001, 5881.882362352729, 5884.499817515473, 5891.0, 1391.3530208453117, 1411.8376386715659, 1419.3754747910887, 1421.3248706864363, 1422.2959634980543, 893.271983333581, 899.5502248875562, 902.5487256371814, 903.0021825882436, 921.6221349246777, 5046.9747651261505, 5100.4899510049445, 5105.668131571436, 5107.463716309809, 5107.923381149286, 6021.0, 6036.366181550961, 6080.391960803884, 6092.208012958376, 6109.908351374733, 5130.769115389817, 5153.587712982952, 5170.250313704491, 5172.405173405032, 5182.144946083854, 3282.3271229397915, 3299.5215693724276, 3307.6361600223954, 3324.1191084362663, 3327.1515763480156, 5685.317761868602, 5827.446392592697, 5838.649681019152, 5843.737031833578, 5851.853703657443, 6337.524685648595, 6341.334159913143, 6359.8092057238355, 6375.458086062644, 6394.104825324365, 5787.045137552257, 5823.126531020296, 5830.766769329264, 5842.357340692521, 5853.619514731614, 6036.33600303975, 6136.0, 6144.907826382519, 6148.1699970503405, 6153.969230153821, 5982.282126144891, 6012.428819262163, 6028.065649824284, 6040.486558642565, 6042.637441753509, 5762.481376675952, 5776.277965254343, 5812.3025236971835, 5830.53355731532, 5845.824625261249, 4056.6957478188665, 4098.508179018537, 4104.445899803488, 4110.691698122593, 4112.527059388209, 5886.646801191942, 6070.332263450929, 6077.908831367445, 6078.300995385587, 6089.69551522431, 5826.592138550261, 5850.531957443309, 5855.209546711139, 5863.472287494146, 5878.177055212359, 5845.269341332333, 5854.736536855767, 5863.325717542367, 5864.354920958605, 5869.442402971711, 5574.16387541872, 5709.400512946081, 5790.218320526675, 5792.797252096157, 5798.449147330997, 5966.850828729316, 5967.880642387041, 5974.522038236843, 5988.191594134736, 5988.730507127277, 5603.719814009201, 5726.713664316851, 5734.197212390352, 5772.913406298993, 5790.94209057904], "unit": "ms", "name": "prototype.html", "value": 4309.543804012977}, {"lowerIsBetter": false, "replicates": [702.7891632510248, 801.6472751989127, 801.6512816924642, 803.3452736020143, 809.0251247247068, 11449.484773185206, 11683.766324673501, 11711.063114950804, 11711.765764684711, 11729.413529323532, 10716.249862509609, 13357.265350405749, 13651.180929144233, 13698.863011369884, 13725.588232353046, 786.7679034684768, 797.7566842113154, 800.1118758178417, 805.2913436176186, 822.9876551851727, 797.2784629909912, 800.3557136505111, 801.3509057663312, 804.3364224514769, 805.0621026504116, 826.801567623772, 831.9792005199888, 834.7412302186311, 838.2078935406043, 838.8741688746676, 821.7904434369258, 823.3207603726919, 824.9175082491763, 826.3678286111129, 831.2228066757601, 616.6700815063964, 617.324030186949, 618.2982315072425, 619.0435776724926, 620.4818976154916, 12545.74908501834, 12645.988320934302, 12748.107632465732, 12750.61748147557, 12780.61658150257, 11166.106711463064, 11367.4884630191, 11371.0, 11721.589744358991, 11809.173357864953, 9181.954090229572, 9216.170544651013, 9282.953585232099, 9429.858552121723, 9545.331826772059, 3226.9677303226904, 3254.804711717281, 3256.0882952773027, 3264.8694052237884, 3289.3750187464543, 41050.794746026375, 42132.57867421348, 42207.36688949668, 42299.78850105761, 42462.0, 9337.486438245962, 9483.0516948306, 9529.428234305964, 9569.186619137312, 9574.186194173433, 16284.837151628331, 16341.346346146258, 16396.098214598074, 16420.83579164193, 16509.17454127289, 6137.9079313810325, 6273.153124328249, 6298.433141017331, 6328.525360597881, 6365.777197798055, 3530.858765649345, 3544.113971507123, 3576.910577235538, 3594.2452085061905, 3601.8739344123355, 2703.053931124091, 2713.0911144766724, 2736.2748871549056, 2739.1919383781833, 2743.6158937748733, 484.7115966000224, 488.2822251290597, 489.6205440783421, 490.11289565885863, 490.3258020222194, 452.3034526828713, 568.1506148308306, 599.9790007349721, 614.3825455417277, 623.4451338308909, 7298.160711518137, 7441.367483763941, 7525.774226773096, 7575.356094732009, 7696.0, 568.1279236372231, 582.3274118393178, 588.888111258868, 588.9381614930456, 604.1360853978853, 3653.634636536325, 3741.962580374216, 3788.6400791924725, 3839.8080095995088, 3859.6526312632, 45849.0, 46625.766871165426, 46975.76512117486, 52368.0, 52878.73560632172, 42229.57770422318, 43876.780616097356, 44024.779876100416, 44045.0, 46359.07281854344, 41582.58417415787, 41609.0, 42102.36846447244, 42287.0, 42412.0, 7618.69525218985, 7859.371250300077, 8354.289885359813, 8484.91515084866, 8554.91445085541, 30534.38931221319, 30639.693603063683, 30822.69177308198, 31103.68896311008, 31501.212469688442, 36650.633493664725, 39392.80303598464, 41454.37818432786, 41514.58485415228, 42095.1580968385, 9838.212942964688, 10047.598096076075, 10208.795824083329, 10328.793424131325, 10464.843027354444, 11353.205275630626, 11379.146564007568, 11547.884521155018, 12045.397730113635, 12546.498140074294, 10955.780884382428, 11239.494222760159, 11337.03635190985, 11486.0, 11774.293542387484, 11015.394153321644, 11216.158788090763, 11291.661250162508, 11690.824637630272, 11800.409979501163, 10789.244752867224, 10850.728731781768, 10900.291481053706, 11365.715857103638, 11380.94309528447, 9237.0, 9586.185174260267, 9633.855492167764, 9639.566219520279, 9882.160016398686, 8390.916090839013, 8499.787505312417, 8614.526201058752, 8640.438371505832, 8989.865152022856], "unit": "ms", "name": "yui.html", "value": 5825.024652990715}], "name": "dromaeo_css", "value": 6162.71710525344}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 112.0, 113.0, 111.0, 126.0, 111.0, 111.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 154.0, 180.0, 135.0, 152.0, 156.0, 135.0, 174.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 161.0, 164.0, 162.0, 166.0, 170.0, 163.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 74.0, 72.0, 131.0, 79.0, 80.0, 78.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 128.0, 95.0, 93.0, 94.0, 130.0, 95.0, 94.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 114.0, 111.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 152.0, 151.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 72.0, 73.0, 73.0, 72.0, 72.0, 73.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [94.0, 86.0, 87.0, 87.0, 85.0, 86.0, 85.0, 95.0, 86.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 131.0, 122.0, 127.0, 126.0, 124.0, 128.0, 126.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [151.0, 144.0, 148.0, 145.0, 152.0, 146.0, 141.0, 143.0, 146.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 69.0, 70.0, 71.0, 76.0, 72.0, 71.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1539.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.0672268907563], "unit": "score", "name": "Richards", "value": 210.04689999999997}, {"lowerIsBetter": false, "replicates": [184.1620626151013], "unit": "score", "name": "DeltaBlue", "value": 359.02074000000005}, {"lowerIsBetter": false, "replicates": [277.1618625277162], "unit": "score", "name": "Encrypt", "value": 960.3810479999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [707.7140835102618], "unit": "score", "name": "Earley", "value": 941.7122190000003}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21422.686422257506}]} 13:46:36 INFO - RETURN: dromaeo_css: 6162.72 13:46:36 INFO - RETURN: kraken: 1539.10 13:46:36 INFO - RETURN: v8_7: 21422.69 13:46:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21422.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1539.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6162.72"}}} 13:46:36 INFO - Return code: 0 13:46:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:46:36 INFO - # TBPL SUCCESS # 13:46:36 INFO - Running post-action listener: _resource_record_post_action 13:46:36 INFO - Running post-run listener: _resource_record_post_run 13:46:37 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 36864; Write bytes: 504422400; Read time: 492; Write time: 530612 13:46:37 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 230805504; Read time: 140; Write time: 302264 13:46:37 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 32768; Write bytes: 273211392; Read time: 352; Write time: 228320 13:46:37 INFO - Running post-run listener: _upload_blobber_files 13:46:37 INFO - Blob upload gear active. 13:46:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:46:37 INFO - Copying logs to upload dir... 13:46:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.426358 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-05 13:46:37.740748) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 13:46:37.746569) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009934 build_url: 'https://queue.taskcluster.net/v1/task/LvovYXR4Re-p4QPYmmqJeQ/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 13:46:37.800168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:46:37.800647) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449349780.506926-1450065262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 13:46:37.851617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 13:46:37.851975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 13:46:37.852323) ========= ========= Total master_lag: 0.24 =========