builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1449930277.62 results: success (0) buildid: 20151212051132 builduid: 40938524b5404649a67d085ede3774f5 revision: cdcd33fd6e39cd12feb5bb11951e1c981a04bd86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.622111) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.622534) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.622819) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006465 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.656337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.656961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.723467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.723779) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.802750) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.803057) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.803406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.803691) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-12 06:24:38-- 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% 225M=0s 2015-12-12 06:24:38 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.968938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:37.969245) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.018996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.019396) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cdcd33fd6e39cd12feb5bb11951e1c981a04bd86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cdcd33fd6e39cd12feb5bb11951e1c981a04bd86 --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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-12 06:24:38,527 truncating revision to first 12 chars 2015-12-12 06:24:38,527 Setting DEBUG logging. 2015-12-12 06:24:38,527 attempt 1/10 2015-12-12 06:24:38,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cdcd33fd6e39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-12 06:24:38,761 unpacking tar archive at: mozilla-central-cdcd33fd6e39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.494993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.527285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.527563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.536219) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.536497) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-12 06:24:38.536891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-12 06:24:38.537217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:39 INFO - MultiFileLogger online at 20151212 06:24:39 in /builds/slave/test 06:24:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:24:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:39 INFO - {'append_to_log': False, 06:24:39 INFO - 'base_work_dir': '/builds/slave/test', 06:24:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:24:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:39 INFO - 'branch': 'Firefox-Non-PGO', 06:24:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:39 INFO - 'config_files': ('talos/linux_config.py',), 06:24:39 INFO - 'default_actions': ('clobber', 06:24:39 INFO - 'read-buildbot-config', 06:24:39 INFO - 'download-and-extract', 06:24:39 INFO - 'populate-webroot', 06:24:39 INFO - 'create-virtualenv', 06:24:39 INFO - 'install', 06:24:39 INFO - 'run-tests'), 06:24:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:39 INFO - 'download_minidump_stackwalk': True, 06:24:39 INFO - 'download_symbols': 'ondemand', 06:24:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:39 INFO - 'installer_path': 'installer.exe', 06:24:39 INFO - 'log_level': 'info', 06:24:39 INFO - 'log_name': 'talos', 06:24:39 INFO - 'log_to_console': True, 06:24:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:39 INFO - 'opt_config_files': (), 06:24:39 INFO - 'pip_index': False, 06:24:39 INFO - 'sps_profile': False, 06:24:39 INFO - 'sps_profile_interval': 0, 06:24:39 INFO - 'suite': 'dromaeojs-e10s', 06:24:39 INFO - 'system_bits': '64', 06:24:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:39 INFO - 'title': 'talos-linux64-ix-008', 06:24:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:39 INFO - 'use_talos_json': True, 06:24:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:39 INFO - 'work_dir': 'build'} 06:24:39 INFO - ##### 06:24:39 INFO - ##### Running clobber step. 06:24:39 INFO - ##### 06:24:39 INFO - Running pre-action listener: _resource_record_pre_action 06:24:39 INFO - Running main action method: clobber 06:24:39 INFO - rmtree: /builds/slave/test/build 06:24:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:39 INFO - Running post-action listener: _resource_record_post_action 06:24:39 INFO - ##### 06:24:39 INFO - ##### Running read-buildbot-config step. 06:24:39 INFO - ##### 06:24:39 INFO - Running pre-action listener: _resource_record_pre_action 06:24:39 INFO - Running main action method: read_buildbot_config 06:24:39 INFO - Using buildbot properties: 06:24:39 INFO - { 06:24:39 INFO - "properties": { 06:24:39 INFO - "buildnumber": 169, 06:24:39 INFO - "product": "firefox", 06:24:39 INFO - "script_repo_revision": "production", 06:24:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:24:39 INFO - "repository": "", 06:24:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:24:39 INFO - "buildid": "20151212051132", 06:24:39 INFO - "slavename": "talos-linux64-ix-008", 06:24:39 INFO - "pgo_build": "False", 06:24:39 INFO - "basedir": "/builds/slave/test", 06:24:39 INFO - "project": "", 06:24:39 INFO - "platform": "ubuntu64_hw", 06:24:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:24:39 INFO - "slavebuilddir": "test", 06:24:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:24:39 INFO - "branch": "mozilla-central", 06:24:39 INFO - "repo_path": "mozilla-central", 06:24:39 INFO - "stage_platform": "linux64", 06:24:39 INFO - "builduid": "40938524b5404649a67d085ede3774f5", 06:24:39 INFO - "revision": "cdcd33fd6e39cd12feb5bb11951e1c981a04bd86" 06:24:39 INFO - }, 06:24:39 INFO - "sourcestamp": { 06:24:39 INFO - "repository": "", 06:24:39 INFO - "hasPatch": false, 06:24:39 INFO - "project": "", 06:24:39 INFO - "branch": "mozilla-central-linux64-talos", 06:24:39 INFO - "changes": [ 06:24:39 INFO - { 06:24:39 INFO - "category": null, 06:24:39 INFO - "files": [ 06:24:39 INFO - { 06:24:39 INFO - "url": null, 06:24:39 INFO - "name": "https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:24:39 INFO - } 06:24:39 INFO - ], 06:24:39 INFO - "repository": "", 06:24:39 INFO - "rev": "cdcd33fd6e39cd12feb5bb11951e1c981a04bd86", 06:24:39 INFO - "who": "ryanvm@gmail.com", 06:24:39 INFO - "when": 1449930236, 06:24:39 INFO - "number": 7354889, 06:24:39 INFO - "comments": "Merge fx-team to m-c. a=merge", 06:24:39 INFO - "project": "", 06:24:39 INFO - "at": "Sat 12 Dec 2015 06:23:56", 06:24:39 INFO - "branch": "mozilla-central-linux64-talos", 06:24:39 INFO - "revlink": "", 06:24:39 INFO - "properties": [ 06:24:39 INFO - [ 06:24:39 INFO - "buildid", 06:24:39 INFO - "20151212051132", 06:24:39 INFO - "Change" 06:24:39 INFO - ], 06:24:39 INFO - [ 06:24:39 INFO - "builduid", 06:24:39 INFO - "40938524b5404649a67d085ede3774f5", 06:24:39 INFO - "Change" 06:24:39 INFO - ], 06:24:39 INFO - [ 06:24:39 INFO - "pgo_build", 06:24:39 INFO - "False", 06:24:39 INFO - "Change" 06:24:39 INFO - ] 06:24:39 INFO - ], 06:24:39 INFO - "revision": "cdcd33fd6e39cd12feb5bb11951e1c981a04bd86" 06:24:39 INFO - } 06:24:39 INFO - ], 06:24:39 INFO - "revision": "cdcd33fd6e39cd12feb5bb11951e1c981a04bd86" 06:24:39 INFO - } 06:24:39 INFO - } 06:24:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:24:39 INFO - Running post-action listener: _resource_record_post_action 06:24:39 INFO - ##### 06:24:39 INFO - ##### Running download-and-extract step. 06:24:39 INFO - ##### 06:24:39 INFO - Running pre-action listener: _resource_record_pre_action 06:24:39 INFO - Running main action method: download_and_extract 06:24:39 INFO - mkdir: /builds/slave/test/build/tests 06:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:39 INFO - https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/test_packages.json 06:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/test_packages.json 06:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:24:45 INFO - Downloaded 1302 bytes. 06:24:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:24:45 INFO - Using the following test package requirements: 06:24:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'jsshell-linux-x86_64.zip'], 06:24:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:24:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:24:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24:45 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')]} 06:24:45 INFO - https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:49 INFO - Downloaded 21869713 bytes. 06:24:49 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 06:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:49 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 06:24:50 INFO - Return code: 0 06:24:50 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 06:24: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')]} 06:24:50 INFO - https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:51 INFO - Downloaded 21869713 bytes. 06:24:51 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 06:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:24:51 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 06:24:52 INFO - Return code: 0 06:24:52 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')]} 06:24:52 INFO - https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:53 INFO - Downloaded 11132038 bytes. 06:24:53 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 06:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:53 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 06:24:53 INFO - Return code: 0 06:24: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')]} 06:24:53 INFO - https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ht68t1pGTLq11_RW_2q16w/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 06:24:56 INFO - Downloaded 57742568 bytes. 06:24:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:24:56 INFO - mkdir: /builds/slave/test/properties 06:24:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:56 INFO - Contents: 06:24:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:24:56 INFO - Running post-action listener: _resource_record_post_action 06:24:56 INFO - Running post-action listener: set_extra_try_arguments 06:24:56 INFO - ##### 06:24:56 INFO - ##### Running populate-webroot step. 06:24:56 INFO - ##### 06:24:56 INFO - Running pre-action listener: _resource_record_pre_action 06:24:56 INFO - Running main action method: populate_webroot 06:24:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:56 INFO - '--tppagecycles', 06:24:56 INFO - '7'], 06:24:56 INFO - 'tests': ['tsvgm']}}, 06:24:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:24:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:24:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:24:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'tests': ['damp', 'tps']}, 06:24:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['damp', 'tps']}, 06:24:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:24:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:56 INFO - 'other': {'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'other_l64': {'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'other_nol64': {'tests': ['a11yr', 06:24:56 INFO - 'ts_paint', 06:24:56 INFO - 'tpaint', 06:24:56 INFO - 'sessionrestore', 06:24:56 INFO - 'sessionrestore_no_auto_restore']}, 06:24:56 INFO - 'svgr': {'tests': ['tsvgx', 06:24:56 INFO - 'tsvgr_opacity', 06:24:56 INFO - 'tart', 06:24:56 INFO - 'tscrollx', 06:24:56 INFO - 'cart']}, 06:24:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['tsvgx', 06:24:56 INFO - 'tsvgr_opacity', 06:24:56 INFO - 'tart', 06:24:56 INFO - 'tscrollx', 06:24:56 INFO - 'cart']}, 06:24:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'tests': ['tp5o']}, 06:24:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'talos_options': ['--e10s'], 06:24:56 INFO - 'tests': ['tp5o']}, 06:24:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'talos_options': ['--xperf_path', 06:24:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:56 INFO - 'tests': ['tp5n']}, 06:24:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:56 INFO - 'talos_options': ['--e10s', 06:24:56 INFO - '--xperf_path', 06:24:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:56 INFO - 'tests': ['tp5n']}}, 06:24:56 INFO - 'talos.zip': {'path': '', 06:24:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:56 INFO - Running post-action listener: _resource_record_post_action 06:24:56 INFO - ##### 06:24:56 INFO - ##### Running create-virtualenv step. 06:24:56 INFO - ##### 06:24:56 INFO - Running pre-action listener: _resource_record_pre_action 06:24:56 INFO - Running main action method: create_virtualenv 06:24:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:56 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 06:24:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:56 INFO - Using real prefix '/usr' 06:24:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:58 INFO - Installing pip.................done. 06:24:58 INFO - Return code: 0 06:24:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:58 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:24:58 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 06:24:58 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 06:24:58 INFO - Using env: {'DISPLAY': ':0', 06:24:58 INFO - 'HOME': '/home/cltbld', 06:24:58 INFO - 'LANG': 'en_US.UTF-8', 06:24:58 INFO - 'LANGUAGE': 'en_US:en', 06:24:58 INFO - 'LOGNAME': 'cltbld', 06:24:58 INFO - 'MAIL': '/var/mail/cltbld', 06:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:58 INFO - 'MOZ_NO_REMOTE': '1', 06:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:58 INFO - 'NO_EM_RESTART': '1', 06:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:58 INFO - 'PWD': '/builds/slave/test', 06:24:58 INFO - 'SHELL': '/bin/bash', 06:24:58 INFO - 'SHLVL': '1', 06:24:58 INFO - 'TERM': 'linux', 06:24:58 INFO - 'TMOUT': '86400', 06:24:58 INFO - 'USER': 'cltbld', 06:24:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:58 INFO - '_': '/tools/buildbot/bin/python'} 06:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:59 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 06:24:59 INFO - Cleaning up... 06:24:59 INFO - Return code: 0 06:24:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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', '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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:24: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:24: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 psutil>=0.7.1 06:24:59 INFO - Using env: {'DISPLAY': ':0', 06:24:59 INFO - 'HOME': '/home/cltbld', 06:24:59 INFO - 'LANG': 'en_US.UTF-8', 06:24:59 INFO - 'LANGUAGE': 'en_US:en', 06:24:59 INFO - 'LOGNAME': 'cltbld', 06:24:59 INFO - 'MAIL': '/var/mail/cltbld', 06:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:59 INFO - 'MOZ_NO_REMOTE': '1', 06:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:59 INFO - 'NO_EM_RESTART': '1', 06:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:59 INFO - 'PWD': '/builds/slave/test', 06:24:59 INFO - 'SHELL': '/bin/bash', 06:24:59 INFO - 'SHLVL': '1', 06:24:59 INFO - 'TERM': 'linux', 06:24:59 INFO - 'TMOUT': '86400', 06:24:59 INFO - 'USER': 'cltbld', 06:24:59 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:59 INFO - '_': '/tools/buildbot/bin/python'} 06:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:59 INFO - Downloading/unpacking psutil>=0.7.1 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:25:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:01 INFO - Installing collected packages: psutil 06:25:01 INFO - Running setup.py install for psutil 06:25:01 INFO - building 'psutil._psutil_linux' extension 06:25:01 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 06:25:01 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 06:25:01 INFO - building 'psutil._psutil_posix' extension 06:25:01 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 06:25:01 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 06:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:01 INFO - Successfully installed psutil 06:25:01 INFO - Cleaning up... 06:25:01 INFO - Return code: 0 06:25:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:25:01 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')]} 06:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:01 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')]} 06:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:01 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:01 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 06:25:01 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 06:25:01 INFO - Using env: {'DISPLAY': ':0', 06:25:01 INFO - 'HOME': '/home/cltbld', 06:25:01 INFO - 'LANG': 'en_US.UTF-8', 06:25:01 INFO - 'LANGUAGE': 'en_US:en', 06:25:01 INFO - 'LOGNAME': 'cltbld', 06:25:01 INFO - 'MAIL': '/var/mail/cltbld', 06:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:01 INFO - 'MOZ_NO_REMOTE': '1', 06:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:01 INFO - 'NO_EM_RESTART': '1', 06:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:01 INFO - 'PWD': '/builds/slave/test', 06:25:01 INFO - 'SHELL': '/bin/bash', 06:25:01 INFO - 'SHLVL': '1', 06:25:01 INFO - 'TERM': 'linux', 06:25:01 INFO - 'TMOUT': '86400', 06:25:01 INFO - 'USER': 'cltbld', 06:25:01 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:01 INFO - '_': '/tools/buildbot/bin/python'} 06:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:25:03 INFO - Installing collected packages: mozsystemmonitor 06:25:03 INFO - Running setup.py install for mozsystemmonitor 06:25:04 INFO - Successfully installed mozsystemmonitor 06:25:04 INFO - Cleaning up... 06:25:04 INFO - Return code: 0 06:25:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:04 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 06:25:04 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 06:25:04 INFO - Using env: {'DISPLAY': ':0', 06:25:04 INFO - 'HOME': '/home/cltbld', 06:25:04 INFO - 'LANG': 'en_US.UTF-8', 06:25:04 INFO - 'LANGUAGE': 'en_US:en', 06:25:04 INFO - 'LOGNAME': 'cltbld', 06:25:04 INFO - 'MAIL': '/var/mail/cltbld', 06:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:04 INFO - 'MOZ_NO_REMOTE': '1', 06:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:04 INFO - 'NO_EM_RESTART': '1', 06:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:04 INFO - 'PWD': '/builds/slave/test', 06:25:04 INFO - 'SHELL': '/bin/bash', 06:25:04 INFO - 'SHLVL': '1', 06:25:04 INFO - 'TERM': 'linux', 06:25:04 INFO - 'TMOUT': '86400', 06:25:04 INFO - 'USER': 'cltbld', 06:25:04 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:04 INFO - '_': '/tools/buildbot/bin/python'} 06:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - Downloading docopt-0.6.1.tar.gz 06:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:07 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:07 INFO - Running setup.py install for blobuploader 06:25:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:07 INFO - Running setup.py install for requests 06:25:08 INFO - Running setup.py install for docopt 06:25:08 INFO - Successfully installed blobuploader requests docopt 06:25:08 INFO - Cleaning up... 06:25:08 INFO - Return code: 0 06:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:08 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:08 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 06:25:08 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 06:25:08 INFO - Using env: {'DISPLAY': ':0', 06:25:08 INFO - 'HOME': '/home/cltbld', 06:25:08 INFO - 'LANG': 'en_US.UTF-8', 06:25:08 INFO - 'LANGUAGE': 'en_US:en', 06:25:08 INFO - 'LOGNAME': 'cltbld', 06:25:08 INFO - 'MAIL': '/var/mail/cltbld', 06:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:08 INFO - 'MOZ_NO_REMOTE': '1', 06:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:08 INFO - 'NO_EM_RESTART': '1', 06:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:08 INFO - 'PWD': '/builds/slave/test', 06:25:08 INFO - 'SHELL': '/bin/bash', 06:25:08 INFO - 'SHLVL': '1', 06:25:08 INFO - 'TERM': 'linux', 06:25:08 INFO - 'TMOUT': '86400', 06:25:08 INFO - 'USER': 'cltbld', 06:25:08 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:08 INFO - '_': '/tools/buildbot/bin/python'} 06:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:08 INFO - Running setup.py (path:/tmp/pip-BqmF6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:08 INFO - Running setup.py (path:/tmp/pip-fnwfC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:08 INFO - Running setup.py (path:/tmp/pip-eb1sbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:08 INFO - Running setup.py (path:/tmp/pip-LY26Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:08 INFO - Running setup.py (path:/tmp/pip-rSSXOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:08 INFO - Running setup.py (path:/tmp/pip-wJlP2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:08 INFO - Running setup.py (path:/tmp/pip-kjPbdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:08 INFO - Running setup.py (path:/tmp/pip-nyS3KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:08 INFO - Running setup.py (path:/tmp/pip-ootJDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:09 INFO - Running setup.py (path:/tmp/pip-qkXfNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:09 INFO - Running setup.py (path:/tmp/pip-yqfA7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:09 INFO - Running setup.py (path:/tmp/pip-6nEMKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:09 INFO - Running setup.py (path:/tmp/pip-z3ovQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:09 INFO - Running setup.py (path:/tmp/pip-Cr9vzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:09 INFO - Running setup.py (path:/tmp/pip-Mzmya9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:09 INFO - Running setup.py (path:/tmp/pip-nFjT3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:09 INFO - Running setup.py (path:/tmp/pip-ByWL9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:09 INFO - Running setup.py install for manifestparser 06:25:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:09 INFO - Running setup.py install for mozcrash 06:25:09 INFO - Running setup.py install for mozdebug 06:25:09 INFO - Running setup.py install for mozdevice 06:25:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozfile 06:25:10 INFO - Running setup.py install for mozhttpd 06:25:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozinfo 06:25:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozInstall 06:25:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozleak 06:25:10 INFO - Running setup.py install for mozlog 06:25:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for moznetwork 06:25:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozprocess 06:25:10 INFO - Running setup.py install for mozprofile 06:25:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Running setup.py install for mozrunner 06:25:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:11 INFO - Running setup.py install for mozscreenshot 06:25:11 INFO - Running setup.py install for moztest 06:25:11 INFO - Running setup.py install for mozversion 06:25:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:11 INFO - Cleaning up... 06:25:11 INFO - Return code: 0 06:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:11 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 06:25:11 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 06:25:11 INFO - Using env: {'DISPLAY': ':0', 06:25:11 INFO - 'HOME': '/home/cltbld', 06:25:11 INFO - 'LANG': 'en_US.UTF-8', 06:25:11 INFO - 'LANGUAGE': 'en_US:en', 06:25:11 INFO - 'LOGNAME': 'cltbld', 06:25:11 INFO - 'MAIL': '/var/mail/cltbld', 06:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:11 INFO - 'MOZ_NO_REMOTE': '1', 06:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:11 INFO - 'NO_EM_RESTART': '1', 06:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:11 INFO - 'PWD': '/builds/slave/test', 06:25:11 INFO - 'SHELL': '/bin/bash', 06:25:11 INFO - 'SHLVL': '1', 06:25:11 INFO - 'TERM': 'linux', 06:25:11 INFO - 'TMOUT': '86400', 06:25:11 INFO - 'USER': 'cltbld', 06:25:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:11 INFO - '_': '/tools/buildbot/bin/python'} 06:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:11 INFO - Running setup.py (path:/tmp/pip-hpwkNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:11 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)) 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:11 INFO - Running setup.py (path:/tmp/pip-bQ7QWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:11 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)) 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:11 INFO - Running setup.py (path:/tmp/pip-HXZ_0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:11 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)) 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:11 INFO - Running setup.py (path:/tmp/pip-ouP3oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:11 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)) 06:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:11 INFO - Running setup.py (path:/tmp/pip-mci_DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:12 INFO - Running setup.py (path:/tmp/pip-KOIkpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:12 INFO - Running setup.py (path:/tmp/pip-dCUSc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:12 INFO - Running setup.py (path:/tmp/pip-ND3IUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:12 INFO - Running setup.py (path:/tmp/pip-48bvPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:12 INFO - Running setup.py (path:/tmp/pip-5ydScI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:12 INFO - Running setup.py (path:/tmp/pip-pX6mdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:12 INFO - Running setup.py (path:/tmp/pip-bNXmTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:12 INFO - Running setup.py (path:/tmp/pip-pZOEHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:12 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)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:12 INFO - Running setup.py (path:/tmp/pip-bPoiV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:12 INFO - Running setup.py (path:/tmp/pip-bKXR5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:12 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)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:12 INFO - Running setup.py (path:/tmp/pip-8PQhPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:12 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)) 06:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:12 INFO - Running setup.py (path:/tmp/pip-0srwB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:12 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)) 06:25:12 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)) 06:25:12 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)) 06:25:12 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)) 06:25:12 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)) 06:25:12 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)) 06:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:12 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 06:25:12 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 06:25:12 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 06:25:12 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 06:25:12 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 06:25:12 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 06:25:14 INFO - Downloading blessings-1.5.1.tar.gz 06:25:14 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 06:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:14 INFO - Installing collected packages: blessings 06:25:14 INFO - Running setup.py install for blessings 06:25:14 INFO - Successfully installed blessings 06:25:14 INFO - Cleaning up... 06:25:14 INFO - Return code: 0 06:25:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:15 INFO - Reading from file tmpfile_stdout 06:25:15 INFO - Current package versions: 06:25:15 INFO - argparse == 1.2.1 06:25:15 INFO - blessings == 1.5.1 06:25:15 INFO - blobuploader == 1.2.4 06:25:15 INFO - docopt == 0.6.1 06:25:15 INFO - manifestparser == 1.1 06:25:15 INFO - mozInstall == 1.12 06:25:15 INFO - mozcrash == 0.16 06:25:15 INFO - mozdebug == 0.1 06:25:15 INFO - mozdevice == 0.47 06:25:15 INFO - mozfile == 1.2 06:25:15 INFO - mozhttpd == 0.7 06:25:15 INFO - mozinfo == 0.9 06:25:15 INFO - mozleak == 0.1 06:25:15 INFO - mozlog == 3.1 06:25:15 INFO - moznetwork == 0.27 06:25:15 INFO - mozprocess == 0.22 06:25:15 INFO - mozprofile == 0.27 06:25:15 INFO - mozrunner == 6.11 06:25:15 INFO - mozscreenshot == 0.1 06:25:15 INFO - mozsystemmonitor == 0.0 06:25:15 INFO - moztest == 0.7 06:25:15 INFO - mozversion == 1.4 06:25:15 INFO - psutil == 3.1.1 06:25:15 INFO - requests == 1.2.3 06:25:15 INFO - wsgiref == 0.1.2 06:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:15 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 06:25:15 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 06:25:15 INFO - Using env: {'DISPLAY': ':0', 06:25:15 INFO - 'HOME': '/home/cltbld', 06:25:15 INFO - 'LANG': 'en_US.UTF-8', 06:25:15 INFO - 'LANGUAGE': 'en_US:en', 06:25:15 INFO - 'LOGNAME': 'cltbld', 06:25:15 INFO - 'MAIL': '/var/mail/cltbld', 06:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:15 INFO - 'MOZ_NO_REMOTE': '1', 06:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:15 INFO - 'NO_EM_RESTART': '1', 06:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:15 INFO - 'PWD': '/builds/slave/test', 06:25:15 INFO - 'SHELL': '/bin/bash', 06:25:15 INFO - 'SHLVL': '1', 06:25:15 INFO - 'TERM': 'linux', 06:25:15 INFO - 'TMOUT': '86400', 06:25:15 INFO - 'USER': 'cltbld', 06:25:15 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:15 INFO - '_': '/tools/buildbot/bin/python'} 06:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:25:15 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)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:25:15 INFO - Cleaning up... 06:25:15 INFO - Return code: 0 06:25:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:15 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 06:25:15 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 06:25:15 INFO - Using env: {'DISPLAY': ':0', 06:25:15 INFO - 'HOME': '/home/cltbld', 06:25:15 INFO - 'LANG': 'en_US.UTF-8', 06:25:15 INFO - 'LANGUAGE': 'en_US:en', 06:25:15 INFO - 'LOGNAME': 'cltbld', 06:25:15 INFO - 'MAIL': '/var/mail/cltbld', 06:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:15 INFO - 'MOZ_NO_REMOTE': '1', 06:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:15 INFO - 'NO_EM_RESTART': '1', 06:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:15 INFO - 'PWD': '/builds/slave/test', 06:25:15 INFO - 'SHELL': '/bin/bash', 06:25:15 INFO - 'SHLVL': '1', 06:25:15 INFO - 'TERM': 'linux', 06:25:15 INFO - 'TMOUT': '86400', 06:25:15 INFO - 'USER': 'cltbld', 06:25:15 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:15 INFO - '_': '/tools/buildbot/bin/python'} 06:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:15 INFO - Downloading/unpacking jsonschema 06:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:17 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 06:25:17 INFO - Downloading/unpacking functools32 (from jsonschema) 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:17 INFO - warning: no files found matching '*.txt' 06:25:17 INFO - no previously-included directories found matching 'build' 06:25:17 INFO - no previously-included directories found matching 'dist' 06:25:17 INFO - no previously-included directories found matching '.git*' 06:25:17 INFO - Installing collected packages: jsonschema, functools32 06:25:17 INFO - Running setup.py install for functools32 06:25:17 INFO - warning: no files found matching '*.txt' 06:25:17 INFO - no previously-included directories found matching 'build' 06:25:17 INFO - no previously-included directories found matching 'dist' 06:25:17 INFO - no previously-included directories found matching '.git*' 06:25:17 INFO - Successfully installed jsonschema functools32 06:25:17 INFO - Cleaning up... 06:25:17 INFO - Return code: 0 06:25:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25: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')]} 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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')]} 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 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 0x7f5a6673af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2216240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, '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': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', '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 06:25:17 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 06:25:17 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 06:25:17 INFO - Using env: {'DISPLAY': ':0', 06:25:17 INFO - 'HOME': '/home/cltbld', 06:25:17 INFO - 'LANG': 'en_US.UTF-8', 06:25:17 INFO - 'LANGUAGE': 'en_US:en', 06:25:17 INFO - 'LOGNAME': 'cltbld', 06:25:17 INFO - 'MAIL': '/var/mail/cltbld', 06:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:17 INFO - 'MOZ_NO_REMOTE': '1', 06:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:17 INFO - 'NO_EM_RESTART': '1', 06:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:17 INFO - 'PWD': '/builds/slave/test', 06:25:17 INFO - 'SHELL': '/bin/bash', 06:25:17 INFO - 'SHLVL': '1', 06:25:17 INFO - 'TERM': 'linux', 06:25:17 INFO - 'TMOUT': '86400', 06:25:17 INFO - 'USER': 'cltbld', 06:25:17 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:17 INFO - '_': '/tools/buildbot/bin/python'} 06:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:17 INFO - Downloading/unpacking flake8 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:19 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 06:25:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:19 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 06:25:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:19 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 06:25:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:20 INFO - no previously-included directories found matching 'docs/_build' 06:25:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:20 INFO - Running setup.py install for pep8 06:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:20 INFO - no previously-included directories found matching 'docs/_build' 06:25:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:20 INFO - Cleaning up... 06:25:20 INFO - Return code: 0 06:25:20 INFO - Running post-action listener: _resource_record_post_action 06:25:20 INFO - Running post-action listener: _start_resource_monitoring 06:25:20 INFO - Starting resource monitoring. 06:25:20 INFO - ##### 06:25:20 INFO - ##### Running install step. 06:25:20 INFO - ##### 06:25:20 INFO - Running pre-action listener: _resource_record_pre_action 06:25:20 INFO - Running main action method: install 06:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:20 INFO - Reading from file tmpfile_stdout 06:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:20 INFO - Reading from file tmpfile_stdout 06:25:20 INFO - Output received: 06:25:20 INFO - Usage: mozinstall [options] installer 06:25:20 INFO - Options: 06:25:20 INFO - -h, --help show this help message and exit 06:25:20 INFO - -d DEST, --destination=DEST 06:25:20 INFO - Directory to install application into. [default: 06:25:20 INFO - "/builds/slave/test"] 06:25:20 INFO - --app=APP Application being installed. [default: firefox] 06:25:20 INFO - mkdir: /builds/slave/test/build/application 06:25:20 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'] 06:25:20 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 06:25:35 INFO - Reading from file tmpfile_stdout 06:25:35 INFO - Output received: 06:25:35 INFO - /builds/slave/test/build/application/firefox/firefox 06:25:35 INFO - Running post-action listener: _resource_record_post_action 06:25:35 INFO - ##### 06:25:35 INFO - ##### Running run-tests step. 06:25:35 INFO - ##### 06:25:35 INFO - Running pre-action listener: _resource_record_pre_action 06:25:35 INFO - Running main action method: run_tests 06:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:35 INFO - Python 2.7.3 06:25:35 INFO - Return code: 0 06:25:35 INFO - grabbing minidump binary from tooltool 06:25:35 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')]} 06:25:35 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 0x22a50b0>, '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 0x22a5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a6440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:35 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 06:25:35 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 06:25:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:35 INFO - Return code: 0 06:25:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:25:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:25:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:36 INFO - Return code: 0 06:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 06:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 06:25:36 INFO - Using env: {'DISPLAY': ':0', 06:25:36 INFO - 'HOME': '/home/cltbld', 06:25:36 INFO - 'LANG': 'en_US.UTF-8', 06:25:36 INFO - 'LANGUAGE': 'en_US:en', 06:25:36 INFO - 'LOGNAME': 'cltbld', 06:25:36 INFO - 'MAIL': '/var/mail/cltbld', 06:25:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:36 INFO - 'MOZ_NO_REMOTE': '1', 06:25:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:36 INFO - 'NO_EM_RESTART': '1', 06:25:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:36 INFO - 'PWD': '/builds/slave/test', 06:25:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:36 INFO - 'SHELL': '/bin/bash', 06:25:36 INFO - 'SHLVL': '1', 06:25:36 INFO - 'TERM': 'linux', 06:25:36 INFO - 'TMOUT': '86400', 06:25:36 INFO - 'USER': 'cltbld', 06:25:36 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446', 06:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:36 INFO - '_': '/tools/buildbot/bin/python'} 06:25:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 06:25:36 INFO - mozversion INFO | application_buildid: 20151212051132 06:25:36 INFO - mozversion INFO | application_changeset: cdcd33fd6e39cd12feb5bb11951e1c981a04bd86 06:25:36 INFO - mozversion INFO | application_display_name: Nightly 06:25:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:36 INFO - mozversion INFO | application_name: Firefox 06:25:36 INFO - mozversion INFO | application_remotingname: firefox 06:25:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:25:36 INFO - mozversion INFO | application_vendor: Mozilla 06:25:36 INFO - mozversion INFO | application_version: 45.0a1 06:25:36 INFO - mozversion INFO | platform_buildid: 20151212051132 06:25:36 INFO - mozversion INFO | platform_changeset: cdcd33fd6e39cd12feb5bb11951e1c981a04bd86 06:25:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:25:36 INFO - mozversion INFO | platform_version: 45.0a1 06:25:36 INFO - 2015-12-12 06:25:36,401 DEBUG : using testdate: 1449930336 06:25:36 INFO - 2015-12-12 06:25:36,401 DEBUG : actual date: 1449930336 06:25:36 INFO - 2015-12-12 06:25:36,455 INFO : starting webserver on 'localhost:40570' 06:25:36 INFO - 2015-12-12 06:25:36,456 INFO : Starting test suite talos-linux64-ix-008.e 06:25:36 INFO - 2015-12-12 06:25:36,456 INFO : Starting test dromaeo_css 06:25:36 INFO - 2015-12-12 06:25:36,456 DEBUG : operating with platform_type : linux_ 06:25:36 INFO - 2015-12-12 06:25:36,457 INFO : Initialising browser for dromaeo_css test... 06:25:36 INFO - 2015-12-12 06:25:36,471 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjvTZQ/profile http://localhost:40570/getInfo.html 06:25:41 INFO - 2015-12-12 06:25:41,474 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:25:41 INFO - 2015-12-12 06:25:41,475 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:25:41 INFO - 2015-12-12 06:25:41,475 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:25:41 INFO - 2015-12-12 06:25:41,475 DEBUG : BROWSER_OUTPUT: __metrics 06:25:41 INFO - 2015-12-12 06:25:41,596 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] 06:25:42 INFO - 2015-12-12 06:25:42,518 INFO : Browser initialized. 06:25:42 INFO - 2015-12-12 06:25:42,519 INFO : Running cycle 1/1 for dromaeo_css test... 06:25:42 INFO - 2015-12-12 06:25:42,519 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjvTZQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:25:54 INFO - 2015-12-12 06:25:54,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 143638528 06:25:54 INFO - 2015-12-12 06:25:54,598 DEBUG : BROWSER_OUTPUT: 06:26:44 INFO - 2015-12-12 06:26:44,222 DEBUG : BROWSER_OUTPUT: 1449930404214 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] 06:28:56 INFO - 2015-12-12 06:28:56,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40570/tests/dromaeo/cssquery-ext.html) 06:28:57 INFO - 2015-12-12 06:28:57,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 147271680 06:28:57 INFO - 2015-12-12 06:28:57,182 DEBUG : BROWSER_OUTPUT: 06:31:59 INFO - 2015-12-12 06:31:59,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-ext.html (next: http://localhost:40570/tests/dromaeo/cssquery-jquery.html) 06:31:59 INFO - 2015-12-12 06:31:59,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 145244160 06:31:59 INFO - 2015-12-12 06:31:59,762 DEBUG : BROWSER_OUTPUT: 06:35:01 INFO - 2015-12-12 06:35:01,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40570/tests/dromaeo/cssquery-mootools.html) 06:35:02 INFO - 2015-12-12 06:35:02,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 146690048 06:35:02 INFO - 2015-12-12 06:35:02,155 DEBUG : BROWSER_OUTPUT: 06:38:03 INFO - 2015-12-12 06:38:03,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40570/tests/dromaeo/cssquery-prototype.html) 06:38:04 INFO - 2015-12-12 06:38:04,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 142745600 06:38:04 INFO - 2015-12-12 06:38:04,503 DEBUG : BROWSER_OUTPUT: 06:41:07 INFO - 2015-12-12 06:41:07,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40570/tests/dromaeo/cssquery-yui.html) 06:41:07 INFO - 2015-12-12 06:41:07,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 144670720 06:41:07 INFO - 2015-12-12 06:41:07,787 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/dromaeo/cssquery-yui.html (next: http://localhost:40570/tests/dromaeo/cssquery-dojo.html) 06:44:10 INFO - 2015-12-12 06:44:10,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 147812352 06:44:10 INFO - 2015-12-12 06:44:10,516 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,516 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:44:10 INFO - 2015-12-12 06:44:10,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:44:10 INFO - 2015-12-12 06:44:10,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:44:10 INFO - 2015-12-12 06:44:10,517 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:44:10 INFO - 2015-12-12 06:44:10,517 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2637.4461363113746;2692.3269182704325;2738.123800383878;2750.4499100179964;2755.3800394911136;4642.558956899097;4734.644901632374;4810.182269014267;4811.061842940624;4858.41698996121;4748.643851711118;4763.428388593365;4772.4273087229585;4854.393200849894;4866.416030076387;4432.7118737282135;4469.664775141861;4471.552844715535;4546.386237857896;4578.542145785428;4517.3224016397635;4554.20301447247;4564.657650676196;4587.334836448713;4603.309503574457;4212.578742125794;4325.97837010813;4439.334099885011;4483.3723278741;4547.15877562652;4427.380166776654;4466.486354069291;4469.463664360298;4471.083427897306;4475.977620111878;4449.221386257392;4452.042810795662;4452.554744525554;4462.434100392287;4479.888002799924;4534.251848445003;4635.119327327797;4652.232381657022;4783.306420568998;4811.08589368019;5136.04983078128;5178.637495375326;5183.533481986601;5186.896262074775;5230.607704422146;5040.873978150539;5202.245674377232;5204.375474942994;5209.322788037569;5209.661372010807;4737.502562230985;4750.572448479654;4798.7840547175465;4812.494688057704;4848.490908454632;5239.135542635422;5250.947490525123;5253.868653283698;5284.048871203144;5292.603054770908;4757.452892917289;4868.269759536098;5039.067772462033;5045.369328833895;5067.265246539305;5145.794168233228;5223.843284701465;5246.317978662826;5251.422343542207;5293.973530132324;5141.331626888556;5151.201563757623;5151.5106064923775;5171.043356978896;5208.244804503326;4968.627352948543;4971.751412429364;5116.437191908887;5125.666831655931;5131.871703207375;4282.978585107055;4289.056407590325;4294.699371044059;4304.634106101016;4328.069465065026;3734.607866174067;3751.7373783835415;3766.2655782122224;3783.5838057813617;3793.260314238752;4265.061686429042;4361.912761744811;4383.298672212431;4496.662750293675;4506.909861802746;5156.381234251839;5168.560672342893;5170.379554453414;5180.611454140954;5216.478352164753;4438.045820148684;4463.709858859163;4486.439195100613;4495.213337665896;4536.274196128604;4352.477702675636;4497.865064048084;4527.750973696412;4618.95381046192;4646.97676511622;4892.951070489249;4902.240152776397;4910.582600478856;4912.926306105412;4963.255511673278;4860.684055536521;5149.9227511586605;5161.432242453402;5203.453637368022;5206.869828254173;4713.811447542197;4813.542713442217;4839.685420447659;4866.926996095132;4882.975585122052;5064.46823083571;5075.28945947575;5079.746012699276;5094.083065048327;5123.718195499134;4914;5053.519915608012;5161.458046905021;5175.042617115846;5177.508136727005;4871.95128048715;4880.511948805091;4927.630427717864;4951.752412379438;4982.925256121233;5001.974595207901;5003.124453220599;5008.298838162587;5025.447200807835;5043.5712964398435;4688.367070445446;4788.688735232199;4861.829835955725;4924.778384972757;4961.7519124044375;5052;5055.34280543527;5068.366454193226;5078.542931136216;5082.364704411949;4964.627652925973;4967.05625931072;4971.6022718183185;4971.8011279549855;4972.7762250699525 06:44:10 INFO - 2015-12-12 06:44:10,517 DEBUG : BROWSER_OUTPUT: |1;ext.html;527.2328761651797;546.4153355909178;566.7789562070792;579.7825815319255;581.5086252116962;26941.865290673544;32654.183645408877;32878.17804554881;32932.67067329326;32995.67004329956;38593;38938.610613893856;39283.214335713266;39473.40789888154;39630.60369396305;7829.256220659043;7938.126806051329;7999.800004999864;8002.119766825674;8022.518648881057;7871.5277083374895;7974.401919856005;8008.159143289958;8010.5594192319395;8018.398620103516;7926.643301051467;7961.36309095271;7984.361251099927;8015.398845086613;8021.6390262438035;7909.723159689412;7924.999999999971;7960.6019699015105;7988.920110798876;7990.04119505663;7713.7685869424;7808.414368922354;7817.960910195413;7864.21357864209;7880.605969701492;35774.64225357739;36331.818340908394;36338.63661363379;36342.273154536764;36463.4530482043;2939.5590661400747;3078.599782028322;3104.239461331988;3428.297199074184;3488.720902327833;27797.16608501748;27816.860915695495;28019;28075.859620701765;28730.856345718348;3410.38613049651;3437.089171369564;3447.4311738563106;3462.5325581046486;3573.3925232710503;212141.99999999846;213067;213243;213483;215894;47840.76079619649;49130.26304605434;51219.48780512222;62502.68748656318;64231.67884160549;56161;56173.71913140408;56307.43692563104;56413;56664.43335566674;13475.797863032063;13549.187048777105;13616.65958351049;13660.726785464434;13669.658258543615;8779.473231606124;8840.8673869892;8885.02264750877;8893.28853691703;8940.105989401138;19417.80582194188;20041.39875803728;20056.398308050782;20076.89961550183;20077.799222007594;7121;7193.712251509881;7227.060482137288;7247.094113235846;7267.491275610762;839.6179738219096;842.0905422144069;874.6151693254948;885.9202671759573;978.9951050244703;26099.73900260973;26946.191614251602;27272.86363568209;27332.726672733417;27564;922.8385032619265;944.419182202954;958.7075941837667;981.6122631560636;993.7764003099245;13955.092918960236;13962.720745585031;14199.503017394341;14212.644683882985;14265.928670356581;262221;265581;266412;266812;268108;45445.545544544795;45984;45991.54008459939;46114.308285375744;46168;1199.4062938845327;1199.8140288255333;1201.1231800785476;1203.013528906306;1209.5524655877382;25640;26487.60268595934;26554.601680974414;26628.06801761929;26794.330141746614;43826.342604860314;44467.33299000453;44828.10343793171;45048;45062.549374505834;165802;166320;166573;166798;166980;29041.7095829039;29119;29220.853895731234;29238.70761292445;29251.561226581194;33803.492947605315;33870.491942620385;34618.30763384768;34667.4799877997;38338;28912.710872891003;29601.407971840013;30151.849240754535;31584.263321021663;31921;32682.34635307233;32824;32848.50727239141;33119.50320745239;33221;33954.32091358209;33988.32023359568;34007;34166.14584635404;34690.82654586711;27068.864655676596;28086.859565702856;29790.702092978794;30074.54888176723;30868.691313086583;22867.542649147257;23049.65425518652;23175.59663663966;23351.883240583687;23364.415889602216 06:44:10 INFO - 2015-12-12 06:44:10,517 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.69542716128296;334.86437992613;334.9397108520465;336.7205219667676;336.75921715973084;14972.17653029083;15277.236138193088;15906.204689765524;16166.272517736701;16638.916805415985;10300.38197708138;10527.894721052788;14519.49181778638;15415.383384664628;15428.84571154291;4500.932486012713;4522.163399771036;4624.907501849961;4633.09654617348;4652.930206046912;4615.100055489181;4630.120277147348;4650.395448591678;4655.231886738684;4657.720536767804;3507.842147103374;3616.2948225096115;4598.747068911209;4628.606568441686;5720.084786434171;5710.914336284959;5731.312242530902;5734.799282025151;5752.453516915886;5780.161876527901;4981.2030075187795;5095.108356037716;5115.258287548285;5119.488051194888;5124.02643497738;18363.63272734538;18584.44246672602;18655.906720466446;18782.624347512974;18890.716639250422;1807.9005654688988;1866.1135960418828;1869.5793446474433;1914.0812410043118;1928.257620815996;9794.265430092772;12412.069094817834;12598.748025039447;12711.491540338375;12745.553905613258;1731.7921849378029;1756.9648607027916;1818.3090425638304;1840.300685739424;1906.4566598519355;54912;57725;57979;58709.70645146789;59434.81130377411;9818.90181098194;9956.103950644478;9957.103860652576;10014.49927503622;10038.196944244442;12367;12397.132200746042;12411.44148513301;12441.502339906483;12444.564440244549;6906.205786334636;6950.721971121199;6959.304069593;6974.616396098263;6980.511364204457;6504.9674751625935;6520.673966301666;6551.705173267214;6578.671066446658;6580.341965803477;4146.647534959562;4160;4237.216115018669;4246.384274280212;4247.5964783345535;1621.8702503799668;1639.5655151384892;1684.62938153606;1732.9220185091701;1751.7722696049432;372.8471326756071;386.5863526027124;398.6471972304531;863.1584205399685;871.4117970369975;9629.470379129216;10147.695569132939;10256.333338332985;10279.845802312972;15319.770203446957;795.9363250939911;820.335528222142;825.7027470110755;889.7997950461224;922.7462447826902;6651.534392592472;8521.744347669579;8614.87077693835;8624.870626940601;8642.555190230114;488740;490157;508726;516796;520459;69587;71190;72464.63767681128;72771;73010;1107.3189988157387;1110.555777688931;1112.933224006562;1116.0457808573553;1130.9660710178707;13691.726165476834;13701.314934253049;13749.243791591558;13854.722905541632;13864.792028119384;31558;31974.840125799223;32157.35685286328;32185;32325.35349293048;44231.77884110559;44851;46037.76981115073;46074.308885366074;48099.27851082166;8258;8470.661173553235;9017.143371379709;9021.594028268875;9051.637934482547;10395.376277423378;10412.739681507719;12171.634850954486;15901.52295431139;16119.274632641325;13544.255065971072;13680.452781888613;13682;13803.378847951666;13847.169169849842;13024.153430027018;13246.602601921957;13392.665183370103;13457.231640954307;13696.246706431242;14023.859761402255;14306.499272525412;14375.634314740082;14653;14743.483978060716;8714.956425217833;8724;8738.169873861973;8983.865242021506;8994.145556172152;13780.793288100887;13927.701929181976;14046.859531404556;14260.358283877044;14429.711405772036 06:44:10 INFO - 2015-12-12 06:44:10,518 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.895007349486;1556.245221067782;1611.0414303489426;1627.967440651187;1655.2964989879306;6832.726690932357;6937.3409526095;7171.82070448239;7355.8161045973875;7365.742199023042;7204.0994875640545;7279.9272007279915;7353.154387245469;7359.374453171474;7364.889526657104;2031.8374530037636;2061.4228016155503;2068.700038494417;2070.9171633134733;2072.948176295597;2093.9895300523553;2094.8638338508026;2116.6824976253606;2161.049138379116;2166.1010680567547;2013.959720805583;2035.7557093148769;2057.4650590846336;2066.4523901166126;2067.0904801887195;2070.9896450517726;2103.737032870891;2109.050927082819;2114.37625900359;2115.23851413491;2069.379186244136;2115.132795553831;2126.606577783115;2128.467883029243;2138.230237114653;7246.963765181193;7345.963270183614;7346.926530734678;7347;7363.410927125817;4079.1841631673783;4123.793810309473;4136.875893723193;4138.565450627701;4141.482314710661;2662.8801703923177;2699.757021868041;2743.2867454461784;2782;2790.1350581319653;841.8316336732678;847.5677404523738;858.4034096303072;866.2680035370103;876.2902049340055;9574.090461406155;9677.419354838661;9687.370320929118;9697.903020969841;9728.416295022322;3681.9815900920325;3699.611540788232;3762.6425489578446;3824.9426258606145;3839.6352346527037;7631.885521717179;7657.923420765721;7673.654685539164;7691.077070751546;7713.1515533291295;4189.2459357315365;4231.851885184004;4240.5123410808155;4243.257429949808;4274.252005898955;3909.159530700913;3917;3931.5478719947;3932.2921874062945;3946.052947292629;3109.657937626859;3153.4639111351125;3162.8418579070953;3166.4458719724416;3199.744020478356;848.2069265237024;850.0097386544729;851.4635779458902;851.5486792000249;862.8101817600118;814.2793627639581;819.5369616166847;824.3075816314325;825.9876101858476;883.867419887022;6476.5466417350335;6489.67551622417;6492.610443373318;6513.348665133449;6581;937.3906960475609;947.4930911962205;1043.7077618266896;1053.1522124689698;1053.2206167436043;5062.417821950449;5144.176931690911;5182.170852663556;5195.6622819516615;5231.843044708665;8513.95743021281;8647.956760216159;8804.647814087364;8854.02605713371;8931.464112153291;8660;8705.956470217609;8739.126087391338;8771.561421929006;8809.295256379473;6801.081853949653;6835.487338449636;6900.930990690129;6926.653667316614;6950;6450.54846160783;6457.451116654949;6473.482121430368;6479.092926990319;6519.902201467076;7428.591427471541;7679.961600191963;7698.384129269533;7803.063632364153;7862.606869656609;7826.960865195638;7851.450398472052;7919.08930473003;7961.283484486424;7965;6182.258129024366;6208.81373558794;6240.5334746333665;6258.061290806416;6275.74897004133;6761.932380676327;6771.695273712793;6778.728850846108;6848.794536163923;6865.725370985105;6238.968805155945;6335.524835637253;6337.7781777637565;6485.221773387224;6627.1716035495565;5329.69558873501;5991.64050156992;6146.938530614637;6244.406781355764;6325.399087086719;6065.5754097212775;6102.816915492543;6121.296050954197;6134.969325153345;6143.754249830135;6004.189434426296;6040.0939859019745;6042.3655516170165;6046.0930860369535;6065.514758819196;5940.257467816523;5983.640981541122;6104.481119104748;6120.17377654011;6123.265208174869 06:44:10 INFO - 2015-12-12 06:44:10,520 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.1572395088072;295.643749282115;304.64204559642417;305.54321289671935;308.6358097445014;5527.309086364205;5545;5597.244372009777;5706.572007099463;5845.210896528967;5628.943710562893;5676.347220069693;5713.400092990239;5717.285339332583;5723.885522289552;4181.351890456984;4323.502797178317;4330.783460826962;4331.696781225315;4338.2191205582985;4285.100128972919;4288.914221715564;4290.6138447539715;4302.053548219386;4308.138372325532;4256.723312984662;4259.829606815739;4281.250781113308;4287.464066991626;4291.892702682427;4280.892977675552;4284.18600465912;4309.181255561433;4309.396684464146;4313.352997050436;3738.214974855284;3740.1584643455276;3744.157564547982;3745.700343972503;3751.5498140223076;5286.154215325568;5336.839894803162;5446.1558458439;5455.263539422167;5463.644863083887;4935.35840340757;4950;4951.727654978975;4953.331300274453;4954.9009019819405;5968.582199246054;5971.343152253248;5975.940240597625;5977.611455255438;5977.820665380045;3927.3519869221545;4048.7570745755056;4048.9392659110135;4051.8654776662584;4056.2293164298985;6111.847203819895;6243;6268.937310626881;6272.749090036393;6286.937130628681;4186.727862688916;4192.937105943352;4195.077083041726;4195.244855925902;4200.243956087934;4252.064545799981;4252.425922500484;4260.8721738347895;4261.914761704748;4265.402843601898;4708.317293992352;4918.704877707349;4927.359443272351;4932.53140951609;4939.753012349368;5897.823065308047;5959.165716799652;5961.910571341434;5963.522918166536;5965.433283838029;1472.7717203833422;1505.6160679026777;1505.7816616590533;1507.8190617126015;1509.3811537269667;955.302629080775;998.9950050249702;1004.711442712131;1008.7175590834578;1013.2603199664286;5153.974230128825;5197.792088316501;5212.348456442945;5215.217717342429;5234.26720259164;6135.294441139237;6172.814815555541;6175.320714721377;6188.690565471708;6219.813405597839;5149.330587023738;5197.7141257231215;5206.817761378334;5213.947860521346;5215.921761173586;3276.311974485337;3323.8171900545217;3360.479125735515;3392.168918614955;3404.217030083095;5743.167240750068;5859.150423188614;5882.647041177543;5888.705564721747;5905.586608937333;6395.168628078413;6418.229812422446;6422.935770642327;6423.13287706163;6423.357664233539;5819.127130930309;5825.679587622637;5848.385919478564;5853.443922827325;5862.94137058624;6229;6234.407731265523;6259.2488901332135;6260.499160067275;6262.248530176408;5914.881702366015;6119.35746746603;6127.785527506516;6129.724162412613;6142.754289828356;5830.7959221427045;5853.64878107315;5855.3559108497175;5857.970710146422;5875;4101.487314085739;4124.257633625856;4136.855210067633;4136.903720514127;4138.089620283533;6084.239470066242;6214.161088253209;6226.097215903578;6246.125542424155;6247.00047992319;5962.37395073511;5972.850678733066;5976.671283079472;5982.162497250301;6006.099085137264;5970.5223582114195;5985.521158307238;5988.311344195473;6001.669908155093;6004.909926351021;5688.488036076773;5831.35855055952;5843.532517398683;5844.357120716632;5851.034579294369;6022.1870047543025;6024.33732289439;6026.9698651508215;6034.607750496204;6041.305249896142;5865.090910908816;5880.14737863016;5882.941170588239;5884;5902.291724993029 06:44:10 INFO - 2015-12-12 06:44:10,523 DEBUG : BROWSER_OUTPUT: |5;yui.html;659.7591878964176;665.3280187011118;676.9932300676993;747.1482509938668;753.6834529497609;11635.127365447594;11681.182317237797;11754.412279386017;11789.528418863247;11797.823032654516;11170.888291117106;11805.468753906074;11877.7624447511;11903.285802851813;11937.104717146227;798.872180451128;800.3437181511163;800.8078061265298;815.6085079161976;824.8721448175512;817.6933649881295;820.3027426687328;823.0658202939646;823.2014945502882;823.8434697407504;843.4475418600827;843.6288033265344;847.6609356257485;848.2196379331;849.9320054395633;837.5142417397925;839.3578912132224;844.2401838345477;844.3161039557947;844.9366297527648;624.8156793745856;629.3014753623474;629.7197747002585;630.4578062865932;632.8512799492115;12355.62933112008;12427.627171184879;12481.875181248162;12488.875111248863;12512.186707863959;10931.672049838518;11137.944310278397;11315.15136364776;11324.547018119265;11896.226745261616;9481.762955926088;9580.952095239549;9632.47021413822;9672.854907176397;9690.903090969141;3151.637561680413;3211.951820722691;3213.293075523381;3282.14664187313;3348.631650518441;39027.999999999716;39096.21807563833;39623.60376396228;39636.40545391821;39880.40179397311;9151.954240228757;9179.449233046038;9243.352965292499;9300.767480813034;9329.813403731887;16073.919630401773;16113.67772644564;16121.596960076093;16167.676646467005;16202.675946481004;5983.968836616958;5988.640681559121;6082.908756368658;6116.510679145657;6244.656543890039;3358.983205083959;3469.132716820795;3536.186677064238;3541.2498880296343;3574.803385813805;2583.625374320713;2619.8166128371213;2623.0688105722193;2624.842509449439;2633.210036988934;468.405125490625;478.09401184754694;513.7071869034614;527.8390091022275;530.7213712800733;458.3491442152152;537.7257598624651;616.5037145098239;617.660286842244;620.1318154583529;7623.237676232332;7695.923040769632;7796.9220307796195;7954.403419743542;8054.677812887536;444.2403490032017;486.55966350452894;613.7146227004464;634.6128861394545;649.9285078641345;3515.2793677296095;3646.507721457622;3690.8154592270816;3706.6849317808287;3718.5909549949483;48468.51531484711;48721;48880.511194888306;48891.266631000566;49268.75365623149;43768.12463750771;44038.55961440344;44094.77952610217;44158;44509.55490445054;40004.39993400101;40518.18963620711;40592;40853.18293634111;41378;7342.6695798688115;7396.741114060982;7397.778066658009;7506.174320824595;7619.619019048914;30330.39339213159;30924.38151236918;31591.368172636878;31592;31734.365312694077;38381;39038;39783.60216397799;39826.80086599549;40598;10141.442220677933;10434.321769084985;10471.10995565355;10505.632302869362;10633;11315.830262545904;11329;11716.824247636121;11750.438616110203;11776.293422394683;10568.630097946534;10938.179636527133;10998.505067271832;11222;11354.205205635526;9969.45473451616;10235.437050961971;10373.481325933824;10489.160867130458;10493.52779124926;10416.687499375032;11249.775004500028;11457.541698331974;11894.821577676168;12045.277283363026;9100.59047342858;9183.540822958692;9195;9227.538623068955;9882.160016398686;8645.135486451305;8792.560371981503;8848.247898928406;8897.2882169425;8913.465192088495 06:44:10 INFO - 2015-12-12 06:44:10,523 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:44:10 INFO - 2015-12-12 06:44:10,523 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:44:10 INFO - 2015-12-12 06:44:10,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,320 06:44:10 INFO - 2015-12-12 06:44:10,523 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: __startTimestamp1449931450510__endTimestamp 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4748.64 Median:4866.42 stddev:497.01 (10.2%) stddev-sans-first:470.13 06:44:10 INFO - 2015-12-12 06:44:10,524 DEBUG : BROWSER_OUTPUT: Values: 2637.4 2692.3 2738.1 2750.4 2755.4 4642.6 4734.6 4810.2 4811.1 4858.4 4748.6 4763.4 4772.4 4854.4 4866.4 4432.7 4469.7 4471.6 4546.4 4578.5 4517.3 4554.2 4564.7 4587.3 4603.3 4212.6 4326.0 4439.3 4483.4 4547.2 4427.4 4466.5 4469.5 4471.1 4476.0 4449.2 4452.0 4452.6 4462.4 4479.9 4534.3 4635.1 4652.2 4783.3 4811.1 5136.0 5178.6 5183.5 5186.9 5230.6 5040.9 5202.2 5204.4 5209.3 5209.7 4737.5 4750.6 4798.8 4812.5 4848.5 5239.1 5250.9 5253.9 5284.0 5292.6 4757.5 4868.3 5039.1 5045.4 5067.3 5145.8 5223.8 5246.3 5251.4 5294.0 5141.3 5151.2 5151.5 5171.0 5208.2 4968.6 4971.8 5116.4 5125.7 5131.9 4283.0 4289.1 4294.7 4304.6 4328.1 3734.6 3751.7 3766.3 3783.6 3793.3 4265.1 4361.9 4383.3 4496.7 4506.9 5156.4 5168.6 5170.4 5180.6 5216.5 4438.0 4463.7 4486.4 4495.2 4536.3 4352.5 4497.9 4527.8 4619.0 4647.0 4893.0 4902.2 4910.6 4912.9 4963.3 4860.7 5149.9 5161.4 5203.5 5206.9 4713.8 4813.5 4839.7 4866.9 4883.0 5064.5 5075.3 5079.7 5094.1 5123.7 4914.0 5053.5 5161.5 5175.0 5177.5 4872.0 4880.5 4927.6 4951.8 4982.9 5002.0 5003.1 5008.3 5025.4 5043.6 4688.4 4788.7 4861.8 4924.8 4961.8 5052.0 5055.3 5068.4 5078.5 5082.4 4964.6 4967.1 4971.6 4971.8 4972.8 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37896.52 Median:3432.69 stddev:57078.07 (1662.8%) stddev-sans-first:57169.23 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: Values: 527.2 546.4 566.8 579.8 581.5 26941.9 32654.2 32878.2 32932.7 32995.7 38593.0 38938.6 39283.2 39473.4 39630.6 7829.3 7938.1 7999.8 8002.1 8022.5 7871.5 7974.4 8008.2 8010.6 8018.4 7926.6 7961.4 7984.4 8015.4 8021.6 7909.7 7925.0 7960.6 7988.9 7990.0 7713.8 7808.4 7818.0 7864.2 7880.6 35774.6 36331.8 36338.6 36342.3 36463.5 2939.6 3078.6 3104.2 3428.3 3488.7 27797.2 27816.9 28019.0 28075.9 28730.9 3410.4 3437.1 3447.4 3462.5 3573.4 212142.0 213067.0 213243.0 213483.0 215894.0 47840.8 49130.3 51219.5 62502.7 64231.7 56161.0 56173.7 56307.4 56413.0 56664.4 13475.8 13549.2 13616.7 13660.7 13669.7 8779.5 8840.9 8885.0 8893.3 8940.1 19417.8 20041.4 20056.4 20076.9 20077.8 7121.0 7193.7 7227.1 7247.1 7267.5 839.6 842.1 874.6 885.9 979.0 26099.7 26946.2 27272.9 27332.7 27564.0 922.8 944.4 958.7 981.6 993.8 13955.1 13962.7 14199.5 14212.6 14265.9 262221.0 265581.0 266412.0 266812.0 268108.0 45445.5 45984.0 45991.5 46114.3 46168.0 1199.4 1199.8 1201.1 1203.0 1209.6 25640.0 26487.6 26554.6 26628.1 26794.3 43826.3 44467.3 44828.1 45048.0 45062.5 165802.0 166320.0 166573.0 166798.0 166980.0 29041.7 29119.0 29220.9 29238.7 29251.6 33803.5 33870.5 34618.3 34667.5 38338.0 28912.7 29601.4 30151.8 31584.3 31921.0 32682.3 32824.0 32848.5 33119.5 33221.0 33954.3 33988.3 34007.0 34166.1 34690.8 27068.9 28086.9 29790.7 30074.5 30868.7 22867.5 23049.7 23175.6 23351.9 23364.4 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26785.11 Median:3562.07 stddev:82537.43 (2317.1%) stddev-sans-first:82745.07 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: Values: 334.7 334.9 334.9 336.7 336.8 14972.2 15277.2 15906.2 16166.3 16638.9 10300.4 10527.9 14519.5 15415.4 15428.8 4500.9 4522.2 4624.9 4633.1 4652.9 4615.1 4630.1 4650.4 4655.2 4657.7 3507.8 3616.3 4598.7 4628.6 5720.1 5710.9 5731.3 5734.8 5752.5 5780.2 4981.2 5095.1 5115.3 5119.5 5124.0 18363.6 18584.4 18655.9 18782.6 18890.7 1807.9 1866.1 1869.6 1914.1 1928.3 9794.3 12412.1 12598.7 12711.5 12745.6 1731.8 1757.0 1818.3 1840.3 1906.5 54912.0 57725.0 57979.0 58709.7 59434.8 9818.9 9956.1 9957.1 10014.5 10038.2 12367.0 12397.1 12411.4 12441.5 12444.6 6906.2 6950.7 6959.3 6974.6 6980.5 6505.0 6520.7 6551.7 6578.7 6580.3 4146.6 4160.0 4237.2 4246.4 4247.6 1621.9 1639.6 1684.6 1732.9 1751.8 372.8 386.6 398.6 863.2 871.4 9629.5 10147.7 10256.3 10279.8 15319.8 795.9 820.3 825.7 889.8 922.7 6651.5 8521.7 8614.9 8624.9 8642.6 488740.0 490157.0 508726.0 516796.0 520459.0 69587.0 71190.0 72464.6 72771.0 73010.0 1107.3 1110.6 1112.9 1116.0 1131.0 13691.7 13701.3 13749.2 13854.7 13864.8 31558.0 31974.8 32157.4 32185.0 32325.4 44231.8 44851.0 46037.8 46074.3 48099.3 8258.0 8470.7 9017.1 9021.6 9051.6 10395.4 10412.7 12171.6 15901.5 16119.3 13544.3 13680.5 13682.0 13803.4 13847.2 13024.2 13246.6 13392.7 13457.2 13696.2 14023.9 14306.5 14375.6 14653.0 14743.5 8715.0 8724.0 8738.2 8983.9 8994.1 13780.8 13927.7 14046.9 14260.4 14429.7 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,525 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4956.62 Median:6251.23 stddev:2598.11 (41.6%) stddev-sans-first:2592.41 06:44:10 INFO - 2015-12-12 06:44:10,526 DEBUG : BROWSER_OUTPUT: Values: 1499.9 1556.2 1611.0 1628.0 1655.3 6832.7 6937.3 7171.8 7355.8 7365.7 7204.1 7279.9 7353.2 7359.4 7364.9 2031.8 2061.4 2068.7 2070.9 2072.9 2094.0 2094.9 2116.7 2161.0 2166.1 2014.0 2035.8 2057.5 2066.5 2067.1 2071.0 2103.7 2109.1 2114.4 2115.2 2069.4 2115.1 2126.6 2128.5 2138.2 7247.0 7346.0 7346.9 7347.0 7363.4 4079.2 4123.8 4136.9 4138.6 4141.5 2662.9 2699.8 2743.3 2782.0 2790.1 841.8 847.6 858.4 866.3 876.3 9574.1 9677.4 9687.4 9697.9 9728.4 3682.0 3699.6 3762.6 3824.9 3839.6 7631.9 7657.9 7673.7 7691.1 7713.2 4189.2 4231.9 4240.5 4243.3 4274.3 3909.2 3917.0 3931.5 3932.3 3946.1 3109.7 3153.5 3162.8 3166.4 3199.7 848.2 850.0 851.5 851.5 862.8 814.3 819.5 824.3 826.0 883.9 6476.5 6489.7 6492.6 6513.3 6581.0 937.4 947.5 1043.7 1053.2 1053.2 5062.4 5144.2 5182.2 5195.7 5231.8 8514.0 8648.0 8804.6 8854.0 8931.5 8660.0 8706.0 8739.1 8771.6 8809.3 6801.1 6835.5 6900.9 6926.7 6950.0 6450.5 6457.5 6473.5 6479.1 6519.9 7428.6 7680.0 7698.4 7803.1 7862.6 7827.0 7851.5 7919.1 7961.3 7965.0 6182.3 6208.8 6240.5 6258.1 6275.7 6761.9 6771.7 6778.7 6848.8 6865.7 6239.0 6335.5 6337.8 6485.2 6627.2 5329.7 5991.6 6146.9 6244.4 6325.4 6065.6 6102.8 6121.3 6135.0 6143.8 6004.2 6040.1 6042.4 6046.1 6065.5 5940.3 5983.6 6104.5 6120.2 6123.3 06:44:10 INFO - 2015-12-12 06:44:10,526 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,526 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4921.69 Median:5613.09 stddev:1477.26 (26.3%) stddev-sans-first:1439.99 06:44:10 INFO - 2015-12-12 06:44:10,527 DEBUG : BROWSER_OUTPUT: Values: 294.2 295.6 304.6 305.5 308.6 5527.3 5545.0 5597.2 5706.6 5845.2 5628.9 5676.3 5713.4 5717.3 5723.9 4181.4 4323.5 4330.8 4331.7 4338.2 4285.1 4288.9 4290.6 4302.1 4308.1 4256.7 4259.8 4281.3 4287.5 4291.9 4280.9 4284.2 4309.2 4309.4 4313.4 3738.2 3740.2 3744.2 3745.7 3751.5 5286.2 5336.8 5446.2 5455.3 5463.6 4935.4 4950.0 4951.7 4953.3 4954.9 5968.6 5971.3 5975.9 5977.6 5977.8 3927.4 4048.8 4048.9 4051.9 4056.2 6111.8 6243.0 6268.9 6272.7 6286.9 4186.7 4192.9 4195.1 4195.2 4200.2 4252.1 4252.4 4260.9 4261.9 4265.4 4708.3 4918.7 4927.4 4932.5 4939.8 5897.8 5959.2 5961.9 5963.5 5965.4 1472.8 1505.6 1505.8 1507.8 1509.4 955.3 999.0 1004.7 1008.7 1013.3 5154.0 5197.8 5212.3 5215.2 5234.3 6135.3 6172.8 6175.3 6188.7 6219.8 5149.3 5197.7 5206.8 5213.9 5215.9 3276.3 3323.8 3360.5 3392.2 3404.2 5743.2 5859.2 5882.6 5888.7 5905.6 6395.2 6418.2 6422.9 6423.1 6423.4 5819.1 5825.7 5848.4 5853.4 5862.9 6229.0 6234.4 6259.2 6260.5 6262.2 5914.9 6119.4 6127.8 6129.7 6142.8 5830.8 5853.6 5855.4 5858.0 5875.0 4101.5 4124.3 4136.9 4136.9 4138.1 6084.2 6214.2 6226.1 6246.1 6247.0 5962.4 5972.9 5976.7 5982.2 6006.1 5970.5 5985.5 5988.3 6001.7 6004.9 5688.5 5831.4 5843.5 5844.4 5851.0 6022.2 6024.3 6027.0 6034.6 6041.3 5865.1 5880.1 5882.9 5884.0 5902.3 06:44:10 INFO - 2015-12-12 06:44:10,527 DEBUG : BROWSER_OUTPUT: 06:44:10 INFO - 2015-12-12 06:44:10,527 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12211.88 Median:44066.67 stddev:13657.26 (31.0%) stddev-sans-first:13668.02 06:44:10 INFO - 2015-12-12 06:44:10,527 DEBUG : BROWSER_OUTPUT: Values: 659.8 665.3 677.0 747.1 753.7 11635.1 11681.2 11754.4 11789.5 11797.8 11170.9 11805.5 11877.8 11903.3 11937.1 798.9 800.3 800.8 815.6 824.9 817.7 820.3 823.1 823.2 823.8 843.4 843.6 847.7 848.2 849.9 837.5 839.4 844.2 844.3 844.9 624.8 629.3 629.7 630.5 632.9 12355.6 12427.6 12481.9 12488.9 12512.2 10931.7 11137.9 11315.2 11324.5 11896.2 9481.8 9581.0 9632.5 9672.9 9690.9 3151.6 3212.0 3213.3 3282.1 3348.6 39028.0 39096.2 39623.6 39636.4 39880.4 9152.0 9179.4 9243.4 9300.8 9329.8 16073.9 16113.7 16121.6 16167.7 16202.7 5984.0 5988.6 6082.9 6116.5 6244.7 3359.0 3469.1 3536.2 3541.2 3574.8 2583.6 2619.8 2623.1 2624.8 2633.2 468.4 478.1 513.7 527.8 530.7 458.3 537.7 616.5 617.7 620.1 7623.2 7695.9 7796.9 7954.4 8054.7 444.2 486.6 613.7 634.6 649.9 3515.3 3646.5 3690.8 3706.7 3718.6 48468.5 48721.0 48880.5 48891.3 49268.8 43768.1 44038.6 44094.8 44158.0 44509.6 40004.4 40518.2 40592.0 40853.2 41378.0 7342.7 7396.7 7397.8 7506.2 7619.6 30330.4 30924.4 31591.4 31592.0 31734.4 38381.0 39038.0 39783.6 39826.8 40598.0 10141.4 10434.3 10471.1 10505.6 10633.0 11315.8 11329.0 11716.8 11750.4 11776.3 10568.6 10938.2 10998.5 11222.0 11354.2 9969.5 10235.4 10373.5 10489.2 10493.5 10416.7 11249.8 11457.5 11894.8 12045.3 9100.6 9183.5 9195.0 9227.5 9882.2 8645.1 8792.6 8848.2 8897.3 8913.5 06:44:10 INFO - 2015-12-12 06:44:10,527 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:44:10 INFO - 2015-12-12 06:44:10,528 DEBUG : BROWSER_OUTPUT: 06:44:11 INFO - 2015-12-12 06:44:11,230 INFO : Browser exited with error code: 0 06:44:11 INFO - 2015-12-12 06:44:11,249 INFO : Completed test dromaeo_css (00:18:34) 06:44:11 INFO - 2015-12-12 06:44:11,249 INFO : Starting test kraken 06:44:11 INFO - 2015-12-12 06:44:11,249 DEBUG : operating with platform_type : linux_ 06:44:11 INFO - 2015-12-12 06:44:11,249 INFO : Initialising browser for kraken test... 06:44:11 INFO - 2015-12-12 06:44:11,255 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpobsTr3/profile http://localhost:40570/getInfo.html 06:44:15 INFO - 2015-12-12 06:44:15,860 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:44:15 INFO - 2015-12-12 06:44:15,861 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:44:15 INFO - 2015-12-12 06:44:15,861 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:44:15 INFO - 2015-12-12 06:44:15,861 DEBUG : BROWSER_OUTPUT: __metrics 06:44:16 INFO - 2015-12-12 06:44:16,002 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] 06:44:16 INFO - 2015-12-12 06:44:16,934 INFO : Browser initialized. 06:44:16 INFO - 2015-12-12 06:44:16,934 INFO : Running cycle 1/1 for kraken test... 06:44:16 INFO - 2015-12-12 06:44:16,935 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpobsTr3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:44:28 INFO - 2015-12-12 06:44:28,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 144203776 06:44:28 INFO - 2015-12-12 06:44:28,951 DEBUG : BROWSER_OUTPUT: 06:44:31 INFO - 2015-12-12 06:44:31,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40570/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:32 INFO - 2015-12-12 06:44:32,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 06:44:32 INFO - 2015-12-12 06:44:32,135 DEBUG : BROWSER_OUTPUT: 06:44:34 INFO - 2015-12-12 06:44:34,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40570/tests/kraken/driver.html?testName=audio-dft) 06:44:35 INFO - 2015-12-12 06:44:35,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 144797696 06:44:35 INFO - 2015-12-12 06:44:35,459 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-12-12 06:44:38,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40570/tests/kraken/driver.html?testName=audio-fft) 06:44:38 INFO - 2015-12-12 06:44:38,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 139522048 06:44:38 INFO - 2015-12-12 06:44:38,952 DEBUG : BROWSER_OUTPUT: 06:44:41 INFO - 2015-12-12 06:44:41,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40570/tests/kraken/driver.html?testName=audio-oscillator) 06:44:41 INFO - 2015-12-12 06:44:41,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 140283904 06:44:41 INFO - 2015-12-12 06:44:41,678 DEBUG : BROWSER_OUTPUT: 06:44:43 INFO - 2015-12-12 06:44:43,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:44 INFO - 2015-12-12 06:44:44,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 141877248 06:44:44 INFO - 2015-12-12 06:44:44,497 DEBUG : BROWSER_OUTPUT: 06:44:47 INFO - 2015-12-12 06:44:47,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40570/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:48 INFO - 2015-12-12 06:44:48,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 140828672 06:44:48 INFO - 2015-12-12 06:44:48,170 DEBUG : BROWSER_OUTPUT: 06:44:51 INFO - 2015-12-12 06:44:51,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40570/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:52 INFO - 2015-12-12 06:44:52,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 139177984 06:44:52 INFO - 2015-12-12 06:44:52,258 DEBUG : BROWSER_OUTPUT: 06:44:55 INFO - 2015-12-12 06:44:55,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40570/tests/kraken/driver.html?testName=json-parse-financial) 06:44:55 INFO - 2015-12-12 06:44:55,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 06:44:55 INFO - 2015-12-12 06:44:55,767 DEBUG : BROWSER_OUTPUT: 06:44:57 INFO - 2015-12-12 06:44:57,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:58 INFO - 2015-12-12 06:44:58,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 141213696 06:44:58 INFO - 2015-12-12 06:44:58,127 DEBUG : BROWSER_OUTPUT: 06:45:00 INFO - 2015-12-12 06:45:00,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:00 INFO - 2015-12-12 06:45:00,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 06:45:00 INFO - 2015-12-12 06:45:00,638 DEBUG : BROWSER_OUTPUT: 06:45:02 INFO - 2015-12-12 06:45:02,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:03 INFO - 2015-12-12 06:45:03,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 141766656 06:45:03 INFO - 2015-12-12 06:45:03,414 DEBUG : BROWSER_OUTPUT: 06:45:05 INFO - 2015-12-12 06:45:05,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:06 INFO - 2015-12-12 06:45:06,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 142045184 06:45:06 INFO - 2015-12-12 06:45:06,568 DEBUG : BROWSER_OUTPUT: 06:45:09 INFO - 2015-12-12 06:45:09,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:09 INFO - 2015-12-12 06:45:09,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 06:45:09 INFO - 2015-12-12 06:45:09,757 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40570/tests/kraken/driver.html?testName=ai-astar) 06:45:11 INFO - 2015-12-12 06:45:11,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 06:45:11 INFO - 2015-12-12 06:45:11,798 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,801 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:45:11 INFO - 2015-12-12 06:45:11,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:45:11 INFO - 2015-12-12 06:45:11,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:45:11 INFO - 2015-12-12 06:45:11,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;112;112;116;124;111;111;113;113 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;151;166;131;162;152;131;161;131 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;160;164;168;168;166;161;162 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;76;73;72;125;72;80;72;73 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;93;130;94;94;95;126;96;95;130 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;110;110;110;109;110;110;110 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;149;147;148;147;149;149 06:45:11 INFO - 2015-12-12 06:45:11,802 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;95;96;96;96 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;74;73;76;74;79;74;72;72 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;68;68;68;68;69;68 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;82;84;83;83;88;92;85 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;124;134;123;123;121;125;132;126;128 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;141;150;149;150;138;149;156;153;133 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;74;73;72;71;72;71;72;71;72 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:45:11 INFO - 2015-12-12 06:45:11,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:45:11 INFO - 2015-12-12 06:45:11,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,799 06:45:11 INFO - 2015-12-12 06:45:11,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:45:11 INFO - 2015-12-12 06:45:11,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1449931511799__endTimestamp 06:45:11 INFO - 2015-12-12 06:45:11,804 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,807 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:4.58 (4.1%) stddev-sans-first:4.86 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 112.0 112.0 116.0 124.0 111.0 111.0 113.0 113.0 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:14.76 (9.6%) stddev-sans-first:15.30 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 151.0 166.0 131.0 162.0 152.0 131.0 161.0 131.0 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.84 (1.7%) stddev-sans-first:2.95 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 160.0 164.0 168.0 168.0 166.0 161.0 162.0 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,808 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:73.00 stddev:16.43 (22.5%) stddev-sans-first:17.29 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 76.0 73.0 72.0 125.0 72.0 80.0 72.0 73.0 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.50 stddev:16.52 (17.5%) stddev-sans-first:17.14 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 95.0 93.0 130.0 94.0 94.0 95.0 126.0 96.0 95.0 130.0 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 149.0 147.0 148.0 147.0 149.0 149.0 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.20 Median:74.00 stddev:2.04 (2.8%) stddev-sans-first:2.17 06:45:11 INFO - 2015-12-12 06:45:11,809 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 74.0 73.0 76.0 74.0 79.0 74.0 72.0 72.0 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.96 (3.5%) stddev-sans-first:3.12 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 82.0 84.0 83.0 83.0 88.0 92.0 85.0 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:4.20 (3.3%) stddev-sans-first:4.35 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: Values: 129.0 124.0 134.0 123.0 123.0 121.0 125.0 132.0 126.0 128.0 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:149.50 stddev:7.60 (5.1%) stddev-sans-first:7.54 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: Values: 138.0 141.0 150.0 149.0 150.0 138.0 149.0 156.0 153.0 133.0 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-12-12 06:45:11,810 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:0.94 (1.3%) stddev-sans-first:1.00 06:45:11 INFO - 2015-12-12 06:45:11,811 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 72.0 71.0 72.0 71.0 72.0 71.0 72.0 06:45:11 INFO - 2015-12-12 06:45:11,811 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:45:11 INFO - 2015-12-12 06:45:11,811 DEBUG : BROWSER_OUTPUT: 06:45:12 INFO - 2015-12-12 06:45:12,765 INFO : Browser exited with error code: 0 06:45:12 INFO - 2015-12-12 06:45:12,816 INFO : Completed test kraken (00:01:01) 06:45:12 INFO - 2015-12-12 06:45:12,816 INFO : Starting test v8_7 06:45:12 INFO - 2015-12-12 06:45:12,816 DEBUG : operating with platform_type : linux_ 06:45:12 INFO - 2015-12-12 06:45:12,816 INFO : Initialising browser for v8_7 test... 06:45:12 INFO - 2015-12-12 06:45:12,822 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyUxCA_/profile http://localhost:40570/getInfo.html 06:45:17 INFO - 2015-12-12 06:45:17,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:45:17 INFO - 2015-12-12 06:45:17,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:45:17 INFO - 2015-12-12 06:45:17,371 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:45:17 INFO - 2015-12-12 06:45:17,371 DEBUG : BROWSER_OUTPUT: __metrics 06:45:17 INFO - 2015-12-12 06:45:17,487 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] 06:45:18 INFO - 2015-12-12 06:45:18,362 INFO : Browser initialized. 06:45:18 INFO - 2015-12-12 06:45:18,362 INFO : Running cycle 1/1 for v8_7 test... 06:45:18 INFO - 2015-12-12 06:45:18,363 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyUxCA_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:45:30 INFO - 2015-12-12 06:45:30,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 142712832 06:45:30 INFO - 2015-12-12 06:45:30,339 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40570/tests/v8_7/run.html (next: http://localhost:40570/tests/v8_7/run.html) 06:45:51 INFO - 2015-12-12 06:45:51,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 137580544 06:45:51 INFO - 2015-12-12 06:45:51,992 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,992 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:45:51 INFO - 2015-12-12 06:45:51,992 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:45:51 INFO - 2015-12-12 06:45:51,992 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.0860545524395 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |5;Earley;717.3601147776184 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |7;RegExp;26282.05128205128 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |8;Splay;599.0510083036773 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: __startTimestamp1449931551985__endTimestamp 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,993 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Values: 166.0 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Values: 192.1 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Values: 279.3 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Values: 5208.3 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,994 DEBUG : BROWSER_OUTPUT: Values: 1056.0 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.36 Median:717.36 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: Values: 717.4 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: Values: 12195.1 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26282.05 Median:26282.05 stddev:0.00 (0.0%) 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: Values: 26282.1 06:45:51 INFO - 2015-12-12 06:45:51,995 DEBUG : BROWSER_OUTPUT: 06:45:51 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.05 Median:599.05 stddev:0.00 (0.0%) 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: Values: 599.1 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:45:52 INFO - 2015-12-12 06:45:51,996 DEBUG : BROWSER_OUTPUT: 06:45:52 INFO - 2015-12-12 06:45:52,970 INFO : Browser exited with error code: 0 06:45:52 INFO - 2015-12-12 06:45:52,982 INFO : Completed test v8_7 (00:00:40) 06:45:53 INFO - 2015-12-12 06:45:53,006 INFO : Completed test suite (00:20:16) 06:45:53 INFO - 2015-12-12 06:45:53,006 DEBUG : Working with test: dromaeo_css 06:45:53 INFO - 2015-12-12 06:45:53,006 DEBUG : Generating results file: dromaeo_css 06:45:53 INFO - 2015-12-12 06:45:53,007 DEBUG : Working with test: kraken 06:45:53 INFO - 2015-12-12 06:45:53,007 DEBUG : Generating results file: kraken 06:45:53 INFO - 2015-12-12 06:45:53,008 INFO : javascript benchmark 06:45:53 INFO - 2015-12-12 06:45:53,008 DEBUG : Working with test: v8_7 06:45:53 INFO - 2015-12-12 06:45:53,008 DEBUG : Generating results file: v8_7 06:45:53 INFO - 2015-12-12 06:45:53,008 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:45:53 INFO - 2015-12-12 06:45:53,127 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 06:45:53 INFO - 2015-12-12 06:45:53,127 DEBUG : process_Request line: dromaeo_css 6331.91 graph.html#tests=[[72,94,43]] 06:45:53 INFO - 2015-12-12 06:45:53,127 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:45:53 INFO - 2015-12-12 06:45:53,175 DEBUG : process_Request line: kraken 1532.80 graph.html#tests=[[232,94,43]] 06:45:53 INFO - 2015-12-12 06:45:53,175 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:45:53 INFO - 2015-12-12 06:45:53,206 DEBUG : process_Request line: v8_7 21291.54 graph.html#tests=[[230,94,43]] 06:45:53 INFO - 2015-12-12 06:45:53,207 INFO : javascript benchmark 06:45:53 INFO - 2015-12-12 06:45:53,211 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2637.4461363113746, 2692.3269182704325, 2738.123800383878, 2750.4499100179964, 2755.3800394911136, 4642.558956899097, 4734.644901632374, 4810.182269014267, 4811.061842940624, 4858.41698996121, 4748.643851711118, 4763.428388593365, 4772.4273087229585, 4854.393200849894, 4866.416030076387, 4432.7118737282135, 4469.664775141861, 4471.552844715535, 4546.386237857896, 4578.542145785428, 4517.3224016397635, 4554.20301447247, 4564.657650676196, 4587.334836448713, 4603.309503574457, 4212.578742125794, 4325.97837010813, 4439.334099885011, 4483.3723278741, 4547.15877562652, 4427.380166776654, 4466.486354069291, 4469.463664360298, 4471.083427897306, 4475.977620111878, 4449.221386257392, 4452.042810795662, 4452.554744525554, 4462.434100392287, 4479.888002799924, 4534.251848445003, 4635.119327327797, 4652.232381657022, 4783.306420568998, 4811.08589368019, 5136.04983078128, 5178.637495375326, 5183.533481986601, 5186.896262074775, 5230.607704422146, 5040.873978150539, 5202.245674377232, 5204.375474942994, 5209.322788037569, 5209.661372010807, 4737.502562230985, 4750.572448479654, 4798.7840547175465, 4812.494688057704, 4848.490908454632, 5239.135542635422, 5250.947490525123, 5253.868653283698, 5284.048871203144, 5292.603054770908, 4757.452892917289, 4868.269759536098, 5039.067772462033, 5045.369328833895, 5067.265246539305, 5145.794168233228, 5223.843284701465, 5246.317978662826, 5251.422343542207, 5293.973530132324, 5141.331626888556, 5151.201563757623, 5151.5106064923775, 5171.043356978896, 5208.244804503326, 4968.627352948543, 4971.751412429364, 5116.437191908887, 5125.666831655931, 5131.871703207375, 4282.978585107055, 4289.056407590325, 4294.699371044059, 4304.634106101016, 4328.069465065026, 3734.607866174067, 3751.7373783835415, 3766.2655782122224, 3783.5838057813617, 3793.260314238752, 4265.061686429042, 4361.912761744811, 4383.298672212431, 4496.662750293675, 4506.909861802746, 5156.381234251839, 5168.560672342893, 5170.379554453414, 5180.611454140954, 5216.478352164753, 4438.045820148684, 4463.709858859163, 4486.439195100613, 4495.213337665896, 4536.274196128604, 4352.477702675636, 4497.865064048084, 4527.750973696412, 4618.95381046192, 4646.97676511622, 4892.951070489249, 4902.240152776397, 4910.582600478856, 4912.926306105412, 4963.255511673278, 4860.684055536521, 5149.9227511586605, 5161.432242453402, 5203.453637368022, 5206.869828254173, 4713.811447542197, 4813.542713442217, 4839.685420447659, 4866.926996095132, 4882.975585122052, 5064.46823083571, 5075.28945947575, 5079.746012699276, 5094.083065048327, 5123.718195499134, 4914.0, 5053.519915608012, 5161.458046905021, 5175.042617115846, 5177.508136727005, 4871.95128048715, 4880.511948805091, 4927.630427717864, 4951.752412379438, 4982.925256121233, 5001.974595207901, 5003.124453220599, 5008.298838162587, 5025.447200807835, 5043.5712964398435, 4688.367070445446, 4788.688735232199, 4861.829835955725, 4924.778384972757, 4961.7519124044375, 5052.0, 5055.34280543527, 5068.366454193226, 5078.542931136216, 5082.364704411949, 4964.627652925973, 4967.05625931072, 4971.6022718183185, 4971.8011279549855, 4972.7762250699525], "unit": "ms", "name": "dojo.html", "value": 4717.405003608955}, {"lowerIsBetter": false, "replicates": [527.2328761651797, 546.4153355909178, 566.7789562070792, 579.7825815319255, 581.5086252116962, 26941.865290673544, 32654.183645408877, 32878.17804554881, 32932.67067329326, 32995.67004329956, 38593.0, 38938.610613893856, 39283.214335713266, 39473.40789888154, 39630.60369396305, 7829.256220659043, 7938.126806051329, 7999.800004999864, 8002.119766825674, 8022.518648881057, 7871.5277083374895, 7974.401919856005, 8008.159143289958, 8010.5594192319395, 8018.398620103516, 7926.643301051467, 7961.36309095271, 7984.361251099927, 8015.398845086613, 8021.6390262438035, 7909.723159689412, 7924.999999999971, 7960.6019699015105, 7988.920110798876, 7990.04119505663, 7713.7685869424, 7808.414368922354, 7817.960910195413, 7864.21357864209, 7880.605969701492, 35774.64225357739, 36331.818340908394, 36338.63661363379, 36342.273154536764, 36463.4530482043, 2939.5590661400747, 3078.599782028322, 3104.239461331988, 3428.297199074184, 3488.720902327833, 27797.16608501748, 27816.860915695495, 28019.0, 28075.859620701765, 28730.856345718348, 3410.38613049651, 3437.089171369564, 3447.4311738563106, 3462.5325581046486, 3573.3925232710503, 212141.99999999846, 213067.0, 213243.0, 213483.0, 215894.0, 47840.76079619649, 49130.26304605434, 51219.48780512222, 62502.68748656318, 64231.67884160549, 56161.0, 56173.71913140408, 56307.43692563104, 56413.0, 56664.43335566674, 13475.797863032063, 13549.187048777105, 13616.65958351049, 13660.726785464434, 13669.658258543615, 8779.473231606124, 8840.8673869892, 8885.02264750877, 8893.28853691703, 8940.105989401138, 19417.80582194188, 20041.39875803728, 20056.398308050782, 20076.89961550183, 20077.799222007594, 7121.0, 7193.712251509881, 7227.060482137288, 7247.094113235846, 7267.491275610762, 839.6179738219096, 842.0905422144069, 874.6151693254948, 885.9202671759573, 978.9951050244703, 26099.73900260973, 26946.191614251602, 27272.86363568209, 27332.726672733417, 27564.0, 922.8385032619265, 944.419182202954, 958.7075941837667, 981.6122631560636, 993.7764003099245, 13955.092918960236, 13962.720745585031, 14199.503017394341, 14212.644683882985, 14265.928670356581, 262221.0, 265581.0, 266412.0, 266812.0, 268108.0, 45445.545544544795, 45984.0, 45991.54008459939, 46114.308285375744, 46168.0, 1199.4062938845327, 1199.8140288255333, 1201.1231800785476, 1203.013528906306, 1209.5524655877382, 25640.0, 26487.60268595934, 26554.601680974414, 26628.06801761929, 26794.330141746614, 43826.342604860314, 44467.33299000453, 44828.10343793171, 45048.0, 45062.549374505834, 165802.0, 166320.0, 166573.0, 166798.0, 166980.0, 29041.7095829039, 29119.0, 29220.853895731234, 29238.70761292445, 29251.561226581194, 33803.492947605315, 33870.491942620385, 34618.30763384768, 34667.4799877997, 38338.0, 28912.710872891003, 29601.407971840013, 30151.849240754535, 31584.263321021663, 31921.0, 32682.34635307233, 32824.0, 32848.50727239141, 33119.50320745239, 33221.0, 33954.32091358209, 33988.32023359568, 34007.0, 34166.14584635404, 34690.82654586711, 27068.864655676596, 28086.859565702856, 29790.702092978794, 30074.54888176723, 30868.691313086583, 22867.542649147257, 23049.65425518652, 23175.59663663966, 23351.883240583687, 23364.415889602216], "unit": "ms", "name": "ext.html", "value": 16470.328619174088}, {"lowerIsBetter": false, "replicates": [334.69542716128296, 334.86437992613, 334.9397108520465, 336.7205219667676, 336.75921715973084, 14972.17653029083, 15277.236138193088, 15906.204689765524, 16166.272517736701, 16638.916805415985, 10300.38197708138, 10527.894721052788, 14519.49181778638, 15415.383384664628, 15428.84571154291, 4500.932486012713, 4522.163399771036, 4624.907501849961, 4633.09654617348, 4652.930206046912, 4615.100055489181, 4630.120277147348, 4650.395448591678, 4655.231886738684, 4657.720536767804, 3507.842147103374, 3616.2948225096115, 4598.747068911209, 4628.606568441686, 5720.084786434171, 5710.914336284959, 5731.312242530902, 5734.799282025151, 5752.453516915886, 5780.161876527901, 4981.2030075187795, 5095.108356037716, 5115.258287548285, 5119.488051194888, 5124.02643497738, 18363.63272734538, 18584.44246672602, 18655.906720466446, 18782.624347512974, 18890.716639250422, 1807.9005654688988, 1866.1135960418828, 1869.5793446474433, 1914.0812410043118, 1928.257620815996, 9794.265430092772, 12412.069094817834, 12598.748025039447, 12711.491540338375, 12745.553905613258, 1731.7921849378029, 1756.9648607027916, 1818.3090425638304, 1840.300685739424, 1906.4566598519355, 54912.0, 57725.0, 57979.0, 58709.70645146789, 59434.81130377411, 9818.90181098194, 9956.103950644478, 9957.103860652576, 10014.49927503622, 10038.196944244442, 12367.0, 12397.132200746042, 12411.44148513301, 12441.502339906483, 12444.564440244549, 6906.205786334636, 6950.721971121199, 6959.304069593, 6974.616396098263, 6980.511364204457, 6504.9674751625935, 6520.673966301666, 6551.705173267214, 6578.671066446658, 6580.341965803477, 4146.647534959562, 4160.0, 4237.216115018669, 4246.384274280212, 4247.5964783345535, 1621.8702503799668, 1639.5655151384892, 1684.62938153606, 1732.9220185091701, 1751.7722696049432, 372.8471326756071, 386.5863526027124, 398.6471972304531, 863.1584205399685, 871.4117970369975, 9629.470379129216, 10147.695569132939, 10256.333338332985, 10279.845802312972, 15319.770203446957, 795.9363250939911, 820.335528222142, 825.7027470110755, 889.7997950461224, 922.7462447826902, 6651.534392592472, 8521.744347669579, 8614.87077693835, 8624.870626940601, 8642.555190230114, 488740.0, 490157.0, 508726.0, 516796.0, 520459.0, 69587.0, 71190.0, 72464.63767681128, 72771.0, 73010.0, 1107.3189988157387, 1110.555777688931, 1112.933224006562, 1116.0457808573553, 1130.9660710178707, 13691.726165476834, 13701.314934253049, 13749.243791591558, 13854.722905541632, 13864.792028119384, 31558.0, 31974.840125799223, 32157.35685286328, 32185.0, 32325.35349293048, 44231.77884110559, 44851.0, 46037.76981115073, 46074.308885366074, 48099.27851082166, 8258.0, 8470.661173553235, 9017.143371379709, 9021.594028268875, 9051.637934482547, 10395.376277423378, 10412.739681507719, 12171.634850954486, 15901.52295431139, 16119.274632641325, 13544.255065971072, 13680.452781888613, 13682.0, 13803.378847951666, 13847.169169849842, 13024.153430027018, 13246.602601921957, 13392.665183370103, 13457.231640954307, 13696.246706431242, 14023.859761402255, 14306.499272525412, 14375.634314740082, 14653.0, 14743.483978060716, 8714.956425217833, 8724.0, 8738.169873861973, 8983.865242021506, 8994.145556172152, 13780.793288100887, 13927.701929181976, 14046.859531404556, 14260.358283877044, 14429.711405772036], "unit": "ms", "name": "jquery.html", "value": 8083.336780428282}, {"lowerIsBetter": false, "replicates": [1499.895007349486, 1556.245221067782, 1611.0414303489426, 1627.967440651187, 1655.2964989879306, 6832.726690932357, 6937.3409526095, 7171.82070448239, 7355.8161045973875, 7365.742199023042, 7204.0994875640545, 7279.9272007279915, 7353.154387245469, 7359.374453171474, 7364.889526657104, 2031.8374530037636, 2061.4228016155503, 2068.700038494417, 2070.9171633134733, 2072.948176295597, 2093.9895300523553, 2094.8638338508026, 2116.6824976253606, 2161.049138379116, 2166.1010680567547, 2013.959720805583, 2035.7557093148769, 2057.4650590846336, 2066.4523901166126, 2067.0904801887195, 2070.9896450517726, 2103.737032870891, 2109.050927082819, 2114.37625900359, 2115.23851413491, 2069.379186244136, 2115.132795553831, 2126.606577783115, 2128.467883029243, 2138.230237114653, 7246.963765181193, 7345.963270183614, 7346.926530734678, 7347.0, 7363.410927125817, 4079.1841631673783, 4123.793810309473, 4136.875893723193, 4138.565450627701, 4141.482314710661, 2662.8801703923177, 2699.757021868041, 2743.2867454461784, 2782.0, 2790.1350581319653, 841.8316336732678, 847.5677404523738, 858.4034096303072, 866.2680035370103, 876.2902049340055, 9574.090461406155, 9677.419354838661, 9687.370320929118, 9697.903020969841, 9728.416295022322, 3681.9815900920325, 3699.611540788232, 3762.6425489578446, 3824.9426258606145, 3839.6352346527037, 7631.885521717179, 7657.923420765721, 7673.654685539164, 7691.077070751546, 7713.1515533291295, 4189.2459357315365, 4231.851885184004, 4240.5123410808155, 4243.257429949808, 4274.252005898955, 3909.159530700913, 3917.0, 3931.5478719947, 3932.2921874062945, 3946.052947292629, 3109.657937626859, 3153.4639111351125, 3162.8418579070953, 3166.4458719724416, 3199.744020478356, 848.2069265237024, 850.0097386544729, 851.4635779458902, 851.5486792000249, 862.8101817600118, 814.2793627639581, 819.5369616166847, 824.3075816314325, 825.9876101858476, 883.867419887022, 6476.5466417350335, 6489.67551622417, 6492.610443373318, 6513.348665133449, 6581.0, 937.3906960475609, 947.4930911962205, 1043.7077618266896, 1053.1522124689698, 1053.2206167436043, 5062.417821950449, 5144.176931690911, 5182.170852663556, 5195.6622819516615, 5231.843044708665, 8513.95743021281, 8647.956760216159, 8804.647814087364, 8854.02605713371, 8931.464112153291, 8660.0, 8705.956470217609, 8739.126087391338, 8771.561421929006, 8809.295256379473, 6801.081853949653, 6835.487338449636, 6900.930990690129, 6926.653667316614, 6950.0, 6450.54846160783, 6457.451116654949, 6473.482121430368, 6479.092926990319, 6519.902201467076, 7428.591427471541, 7679.961600191963, 7698.384129269533, 7803.063632364153, 7862.606869656609, 7826.960865195638, 7851.450398472052, 7919.08930473003, 7961.283484486424, 7965.0, 6182.258129024366, 6208.81373558794, 6240.5334746333665, 6258.061290806416, 6275.74897004133, 6761.932380676327, 6771.695273712793, 6778.728850846108, 6848.794536163923, 6865.725370985105, 6238.968805155945, 6335.524835637253, 6337.7781777637565, 6485.221773387224, 6627.1716035495565, 5329.69558873501, 5991.64050156992, 6146.938530614637, 6244.406781355764, 6325.399087086719, 6065.5754097212775, 6102.816915492543, 6121.296050954197, 6134.969325153345, 6143.754249830135, 6004.189434426296, 6040.0939859019745, 6042.3655516170165, 6046.0930860369535, 6065.514758819196, 5940.257467816523, 5983.640981541122, 6104.481119104748, 6120.17377654011, 6123.265208174869], "unit": "ms", "name": "mootools.html", "value": 4032.0664353930506}, {"lowerIsBetter": false, "replicates": [294.1572395088072, 295.643749282115, 304.64204559642417, 305.54321289671935, 308.6358097445014, 5527.309086364205, 5545.0, 5597.244372009777, 5706.572007099463, 5845.210896528967, 5628.943710562893, 5676.347220069693, 5713.400092990239, 5717.285339332583, 5723.885522289552, 4181.351890456984, 4323.502797178317, 4330.783460826962, 4331.696781225315, 4338.2191205582985, 4285.100128972919, 4288.914221715564, 4290.6138447539715, 4302.053548219386, 4308.138372325532, 4256.723312984662, 4259.829606815739, 4281.250781113308, 4287.464066991626, 4291.892702682427, 4280.892977675552, 4284.18600465912, 4309.181255561433, 4309.396684464146, 4313.352997050436, 3738.214974855284, 3740.1584643455276, 3744.157564547982, 3745.700343972503, 3751.5498140223076, 5286.154215325568, 5336.839894803162, 5446.1558458439, 5455.263539422167, 5463.644863083887, 4935.35840340757, 4950.0, 4951.727654978975, 4953.331300274453, 4954.9009019819405, 5968.582199246054, 5971.343152253248, 5975.940240597625, 5977.611455255438, 5977.820665380045, 3927.3519869221545, 4048.7570745755056, 4048.9392659110135, 4051.8654776662584, 4056.2293164298985, 6111.847203819895, 6243.0, 6268.937310626881, 6272.749090036393, 6286.937130628681, 4186.727862688916, 4192.937105943352, 4195.077083041726, 4195.244855925902, 4200.243956087934, 4252.064545799981, 4252.425922500484, 4260.8721738347895, 4261.914761704748, 4265.402843601898, 4708.317293992352, 4918.704877707349, 4927.359443272351, 4932.53140951609, 4939.753012349368, 5897.823065308047, 5959.165716799652, 5961.910571341434, 5963.522918166536, 5965.433283838029, 1472.7717203833422, 1505.6160679026777, 1505.7816616590533, 1507.8190617126015, 1509.3811537269667, 955.302629080775, 998.9950050249702, 1004.711442712131, 1008.7175590834578, 1013.2603199664286, 5153.974230128825, 5197.792088316501, 5212.348456442945, 5215.217717342429, 5234.26720259164, 6135.294441139237, 6172.814815555541, 6175.320714721377, 6188.690565471708, 6219.813405597839, 5149.330587023738, 5197.7141257231215, 5206.817761378334, 5213.947860521346, 5215.921761173586, 3276.311974485337, 3323.8171900545217, 3360.479125735515, 3392.168918614955, 3404.217030083095, 5743.167240750068, 5859.150423188614, 5882.647041177543, 5888.705564721747, 5905.586608937333, 6395.168628078413, 6418.229812422446, 6422.935770642327, 6423.13287706163, 6423.357664233539, 5819.127130930309, 5825.679587622637, 5848.385919478564, 5853.443922827325, 5862.94137058624, 6229.0, 6234.407731265523, 6259.2488901332135, 6260.499160067275, 6262.248530176408, 5914.881702366015, 6119.35746746603, 6127.785527506516, 6129.724162412613, 6142.754289828356, 5830.7959221427045, 5853.64878107315, 5855.3559108497175, 5857.970710146422, 5875.0, 4101.487314085739, 4124.257633625856, 4136.855210067633, 4136.903720514127, 4138.089620283533, 6084.239470066242, 6214.161088253209, 6226.097215903578, 6246.125542424155, 6247.00047992319, 5962.37395073511, 5972.850678733066, 5976.671283079472, 5982.162497250301, 6006.099085137264, 5970.5223582114195, 5985.521158307238, 5988.311344195473, 6001.669908155093, 6004.909926351021, 5688.488036076773, 5831.35855055952, 5843.532517398683, 5844.357120716632, 5851.034579294369, 6022.1870047543025, 6024.33732289439, 6026.9698651508215, 6034.607750496204, 6041.305249896142, 5865.090910908816, 5880.14737863016, 5882.941170588239, 5884.0, 5902.291724993029], "unit": "ms", "name": "prototype.html", "value": 4438.0071277075795}, {"lowerIsBetter": false, "replicates": [659.7591878964176, 665.3280187011118, 676.9932300676993, 747.1482509938668, 753.6834529497609, 11635.127365447594, 11681.182317237797, 11754.412279386017, 11789.528418863247, 11797.823032654516, 11170.888291117106, 11805.468753906074, 11877.7624447511, 11903.285802851813, 11937.104717146227, 798.872180451128, 800.3437181511163, 800.8078061265298, 815.6085079161976, 824.8721448175512, 817.6933649881295, 820.3027426687328, 823.0658202939646, 823.2014945502882, 823.8434697407504, 843.4475418600827, 843.6288033265344, 847.6609356257485, 848.2196379331, 849.9320054395633, 837.5142417397925, 839.3578912132224, 844.2401838345477, 844.3161039557947, 844.9366297527648, 624.8156793745856, 629.3014753623474, 629.7197747002585, 630.4578062865932, 632.8512799492115, 12355.62933112008, 12427.627171184879, 12481.875181248162, 12488.875111248863, 12512.186707863959, 10931.672049838518, 11137.944310278397, 11315.15136364776, 11324.547018119265, 11896.226745261616, 9481.762955926088, 9580.952095239549, 9632.47021413822, 9672.854907176397, 9690.903090969141, 3151.637561680413, 3211.951820722691, 3213.293075523381, 3282.14664187313, 3348.631650518441, 39027.999999999716, 39096.21807563833, 39623.60376396228, 39636.40545391821, 39880.40179397311, 9151.954240228757, 9179.449233046038, 9243.352965292499, 9300.767480813034, 9329.813403731887, 16073.919630401773, 16113.67772644564, 16121.596960076093, 16167.676646467005, 16202.675946481004, 5983.968836616958, 5988.640681559121, 6082.908756368658, 6116.510679145657, 6244.656543890039, 3358.983205083959, 3469.132716820795, 3536.186677064238, 3541.2498880296343, 3574.803385813805, 2583.625374320713, 2619.8166128371213, 2623.0688105722193, 2624.842509449439, 2633.210036988934, 468.405125490625, 478.09401184754694, 513.7071869034614, 527.8390091022275, 530.7213712800733, 458.3491442152152, 537.7257598624651, 616.5037145098239, 617.660286842244, 620.1318154583529, 7623.237676232332, 7695.923040769632, 7796.9220307796195, 7954.403419743542, 8054.677812887536, 444.2403490032017, 486.55966350452894, 613.7146227004464, 634.6128861394545, 649.9285078641345, 3515.2793677296095, 3646.507721457622, 3690.8154592270816, 3706.6849317808287, 3718.5909549949483, 48468.51531484711, 48721.0, 48880.511194888306, 48891.266631000566, 49268.75365623149, 43768.12463750771, 44038.55961440344, 44094.77952610217, 44158.0, 44509.55490445054, 40004.39993400101, 40518.18963620711, 40592.0, 40853.18293634111, 41378.0, 7342.6695798688115, 7396.741114060982, 7397.778066658009, 7506.174320824595, 7619.619019048914, 30330.39339213159, 30924.38151236918, 31591.368172636878, 31592.0, 31734.365312694077, 38381.0, 39038.0, 39783.60216397799, 39826.80086599549, 40598.0, 10141.442220677933, 10434.321769084985, 10471.10995565355, 10505.632302869362, 10633.0, 11315.830262545904, 11329.0, 11716.824247636121, 11750.438616110203, 11776.293422394683, 10568.630097946534, 10938.179636527133, 10998.505067271832, 11222.0, 11354.205205635526, 9969.45473451616, 10235.437050961971, 10373.481325933824, 10489.160867130458, 10493.52779124926, 10416.687499375032, 11249.775004500028, 11457.541698331974, 11894.821577676168, 12045.277283363026, 9100.59047342858, 9183.540822958692, 9195.0, 9227.538623068955, 9882.160016398686, 8645.135486451305, 8792.560371981503, 8848.247898928406, 8897.2882169425, 8913.465192088495], "unit": "ms", "name": "yui.html", "value": 5733.926937572818}], "name": "dromaeo_css", "value": 6331.903817349791}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 112.0, 116.0, 124.0, 111.0, 111.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 151.0, 166.0, 131.0, 162.0, 152.0, 131.0, 161.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 160.0, 164.0, 168.0, 168.0, 166.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 76.0, 73.0, 72.0, 125.0, 72.0, 80.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 130.0, 94.0, 94.0, 95.0, 126.0, 96.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 149.0, 147.0, 148.0, 147.0, 149.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 73.0, 76.0, 74.0, 79.0, 74.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 82.0, 84.0, 83.0, 83.0, 88.0, 92.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 134.0, 123.0, 123.0, 121.0, 125.0, 132.0, 126.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [138.0, 141.0, 150.0, 149.0, 150.0, 138.0, 149.0, 156.0, 153.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 72.0, 71.0, 72.0, 71.0, 72.0, 71.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1532.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [717.3601147776184], "unit": "score", "name": "Earley", "value": 929.0494220000003}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [26282.05128205128], "unit": "score", "name": "RegExp", "value": 34.66186829268295}, {"lowerIsBetter": false, "replicates": [599.0510083036773], "unit": "score", "name": "Splay", "value": 136.03349108910885}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21291.537330662206}]} 06:45:53 INFO - RETURN: dromaeo_css: 6331.91 06:45:53 INFO - RETURN: kraken: 1532.80 06:45:53 INFO - RETURN: v8_7: 21291.54 06:45:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21291.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1532.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6331.91"}}} 06:45:53 INFO - Return code: 0 06:45:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:45:53 INFO - # TBPL SUCCESS # 06:45:53 INFO - Running post-action listener: _resource_record_post_action 06:45:53 INFO - Running post-run listener: _resource_record_post_run 06:45:54 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 114688; Write bytes: 279474176; Read time: 260; Write time: 141288 06:45:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4751360; Read time: 0; Write time: 736 06:45:54 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 114688; Write bytes: 273858560; Read time: 260; Write time: 140512 06:45:54 INFO - Running post-run listener: _upload_blobber_files 06:45:54 INFO - Blob upload gear active. 06:45:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:45:54 INFO - Copying logs to upload dir... 06:45:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.475502 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-12 06:45:54.036035) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-12 06:45:54.039831) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010048 build_url: 'https://queue.taskcluster.net/v1/task/ht68t1pGTLq11_RW_2q16w/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-12 06:45:54.091773) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:45:54.092186) ========= 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=7d909545e45784438f4e8e36000001b3-1449911035.571314-331686446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 06:45:54.142434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-12 06:45:54.142810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-12 06:45:54.143187) ========= ========= Total master_lag: 0.27 =========