builder: ash_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1448489253.48 results: success (0) buildid: 20151125130231 builduid: 16db1a328f6e42e9b2aa1a2b243f3291 revision: ffcf2bb8b1b43b4970e0efeca19643e5e5d78325 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.483623) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.484051) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.486380) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006547 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.512124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.516075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.531571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.531900) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.581163) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.581504) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.581860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.582173) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 14:07:33-- 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% 222M=0s 2015-11-25 14:07:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.701826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.702132) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.758001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:33.758349) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev ffcf2bb8b1b43b4970e0efeca19643e5e5d78325 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev ffcf2bb8b1b43b4970e0efeca19643e5e5d78325 --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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 14:07:34,028 truncating revision to first 12 chars 2015-11-25 14:07:34,028 Setting DEBUG logging. 2015-11-25 14:07:34,028 attempt 1/10 2015-11-25 14:07:34,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/ffcf2bb8b1b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 14:07:34,472 unpacking tar archive at: ash-ffcf2bb8b1b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:34.484407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:34.484765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:34.504593) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:34.504902) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 14:07:34.505292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 14:07:34.505594) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Ash-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash-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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:34 INFO - MultiFileLogger online at 20151125 14:07:34 in /builds/slave/test 14:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO 14:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:34 INFO - {'append_to_log': False, 14:07:34 INFO - 'base_work_dir': '/builds/slave/test', 14:07:34 INFO - 'blob_upload_branch': 'Ash-Non-PGO', 14:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:34 INFO - 'branch': 'Ash-Non-PGO', 14:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:34 INFO - 'config_files': ('talos/linux_config.py',), 14:07:34 INFO - 'default_actions': ('clobber', 14:07:34 INFO - 'read-buildbot-config', 14:07:34 INFO - 'download-and-extract', 14:07:34 INFO - 'populate-webroot', 14:07:34 INFO - 'create-virtualenv', 14:07:34 INFO - 'install', 14:07:34 INFO - 'run-tests'), 14:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:34 INFO - 'download_minidump_stackwalk': True, 14:07:34 INFO - 'download_symbols': 'ondemand', 14:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:34 INFO - 'installer_path': 'installer.exe', 14:07:34 INFO - 'log_level': 'info', 14:07:34 INFO - 'log_name': 'talos', 14:07:34 INFO - 'log_to_console': True, 14:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:34 INFO - 'opt_config_files': (), 14:07:34 INFO - 'pip_index': False, 14:07:34 INFO - 'sps_profile': False, 14:07:34 INFO - 'sps_profile_interval': 0, 14:07:34 INFO - 'suite': 'dromaeojs', 14:07:34 INFO - 'system_bits': '64', 14:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:34 INFO - 'title': 'talos-linux64-ix-054', 14:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:34 INFO - 'use_talos_json': True, 14:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:34 INFO - 'work_dir': 'build'} 14:07:34 INFO - ##### 14:07:34 INFO - ##### Running clobber step. 14:07:34 INFO - ##### 14:07:34 INFO - Running pre-action listener: _resource_record_pre_action 14:07:34 INFO - Running main action method: clobber 14:07:34 INFO - rmtree: /builds/slave/test/build 14:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:35 INFO - Running post-action listener: _resource_record_post_action 14:07:35 INFO - ##### 14:07:35 INFO - ##### Running read-buildbot-config step. 14:07:35 INFO - ##### 14:07:35 INFO - Running pre-action listener: _resource_record_pre_action 14:07:35 INFO - Running main action method: read_buildbot_config 14:07:35 INFO - Using buildbot properties: 14:07:35 INFO - { 14:07:35 INFO - "properties": { 14:07:35 INFO - "buildnumber": 1, 14:07:35 INFO - "product": "firefox", 14:07:35 INFO - "script_repo_revision": "production", 14:07:35 INFO - "builddir": "ash_ubuntu64_hw_test-dromaeojs", 14:07:35 INFO - "repository": "", 14:07:35 INFO - "buildername": "Ubuntu HW 12.04 x64 ash talos dromaeojs", 14:07:35 INFO - "buildid": "20151125130231", 14:07:35 INFO - "slavename": "talos-linux64-ix-054", 14:07:35 INFO - "pgo_build": "False", 14:07:35 INFO - "basedir": "/builds/slave/test", 14:07:35 INFO - "project": "", 14:07:35 INFO - "platform": "ubuntu64_hw", 14:07:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:07:35 INFO - "slavebuilddir": "test", 14:07:35 INFO - "scheduler": "tests-ash-linux64-talos", 14:07:35 INFO - "branch": "ash", 14:07:35 INFO - "repo_path": "projects/ash", 14:07:35 INFO - "stage_platform": "linux64", 14:07:35 INFO - "builduid": "16db1a328f6e42e9b2aa1a2b243f3291", 14:07:35 INFO - "revision": "ffcf2bb8b1b43b4970e0efeca19643e5e5d78325" 14:07:35 INFO - }, 14:07:35 INFO - "sourcestamp": { 14:07:35 INFO - "repository": "", 14:07:35 INFO - "hasPatch": false, 14:07:35 INFO - "project": "", 14:07:35 INFO - "branch": "ash-linux64-talos", 14:07:35 INFO - "changes": [ 14:07:35 INFO - { 14:07:35 INFO - "category": null, 14:07:35 INFO - "files": [ 14:07:35 INFO - { 14:07:35 INFO - "url": null, 14:07:35 INFO - "name": "https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:07:35 INFO - } 14:07:35 INFO - ], 14:07:35 INFO - "repository": "", 14:07:35 INFO - "rev": "ffcf2bb8b1b43b4970e0efeca19643e5e5d78325", 14:07:35 INFO - "who": "nthomas@mozilla.com", 14:07:35 INFO - "when": 1448489233, 14:07:35 INFO - "number": 6707663, 14:07:35 INFO - "comments": "Bug 1222227, verify disabling uploads works", 14:07:35 INFO - "project": "", 14:07:35 INFO - "at": "Wed 25 Nov 2015 14:07:13", 14:07:35 INFO - "branch": "ash-linux64-talos", 14:07:35 INFO - "revlink": "", 14:07:35 INFO - "properties": [ 14:07:35 INFO - [ 14:07:35 INFO - "buildid", 14:07:35 INFO - "20151125130231", 14:07:35 INFO - "Change" 14:07:35 INFO - ], 14:07:35 INFO - [ 14:07:35 INFO - "builduid", 14:07:35 INFO - "16db1a328f6e42e9b2aa1a2b243f3291", 14:07:35 INFO - "Change" 14:07:35 INFO - ], 14:07:35 INFO - [ 14:07:35 INFO - "pgo_build", 14:07:35 INFO - "False", 14:07:35 INFO - "Change" 14:07:35 INFO - ] 14:07:35 INFO - ], 14:07:35 INFO - "revision": "ffcf2bb8b1b43b4970e0efeca19643e5e5d78325" 14:07:35 INFO - } 14:07:35 INFO - ], 14:07:35 INFO - "revision": "ffcf2bb8b1b43b4970e0efeca19643e5e5d78325" 14:07:35 INFO - } 14:07:35 INFO - } 14:07:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:07:35 INFO - Running post-action listener: _resource_record_post_action 14:07:35 INFO - ##### 14:07:35 INFO - ##### Running download-and-extract step. 14:07:35 INFO - ##### 14:07:35 INFO - Running pre-action listener: _resource_record_pre_action 14:07:35 INFO - Running main action method: download_and_extract 14:07:35 INFO - mkdir: /builds/slave/test/build/tests 14:07: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')]} 14:07:35 INFO - https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/test_packages.json 14:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/test_packages.json 14:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:07:36 INFO - Downloaded 1302 bytes. 14:07:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:07:36 INFO - Using the following test package requirements: 14:07:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'jsshell-linux-x86_64.zip'], 14:07:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:36 INFO - https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:39 INFO - Downloaded 21345020 bytes. 14:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:07:40 INFO - Return code: 0 14:07:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:40 INFO - https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:43 INFO - Downloaded 21345020 bytes. 14:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:07:44 INFO - Return code: 0 14:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:44 INFO - https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:45 INFO - Downloaded 11131717 bytes. 14:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:07:45 INFO - Return code: 0 14:07: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')]} 14:07:45 INFO - https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:07:49 INFO - Downloaded 52113390 bytes. 14:07:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:49 INFO - mkdir: /builds/slave/test/properties 14:07:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:49 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:49 INFO - Contents: 14:07:49 INFO - build_url:https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:49 INFO - Running post-action listener: _resource_record_post_action 14:07:49 INFO - Running post-action listener: set_extra_try_arguments 14:07:49 INFO - ##### 14:07:49 INFO - ##### Running populate-webroot step. 14:07:49 INFO - ##### 14:07:49 INFO - Running pre-action listener: _resource_record_pre_action 14:07:49 INFO - Running main action method: populate_webroot 14:07:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:07:49 INFO - '../fennec_ids.txt'], 14:07:49 INFO - 'tests': ['tcheck2']}, 14:07:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:49 INFO - '--tppagecycles', 14:07:49 INFO - '7'], 14:07:49 INFO - 'tests': ['tsvgm']}}, 14:07:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:07:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'tests': ['damp', 'tps']}, 14:07:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['damp', 'tps']}, 14:07:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:07:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:49 INFO - 'other': {'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'other_l64': {'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'other_nol64': {'tests': ['a11yr', 14:07:49 INFO - 'ts_paint', 14:07:49 INFO - 'tpaint', 14:07:49 INFO - 'sessionrestore', 14:07:49 INFO - 'sessionrestore_no_auto_restore']}, 14:07:49 INFO - 'svgr': {'tests': ['tsvgx', 14:07:49 INFO - 'tsvgr_opacity', 14:07:49 INFO - 'tart', 14:07:49 INFO - 'tscrollx', 14:07:49 INFO - 'cart']}, 14:07:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['tsvgx', 14:07:49 INFO - 'tsvgr_opacity', 14:07:49 INFO - 'tart', 14:07:49 INFO - 'tscrollx', 14:07:49 INFO - 'cart']}, 14:07:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'tests': ['tp5o']}, 14:07:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'talos_options': ['--e10s'], 14:07:49 INFO - 'tests': ['tp5o']}, 14:07:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'talos_options': ['--xperf_path', 14:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:49 INFO - 'tests': ['tp5n']}, 14:07:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:49 INFO - 'talos_options': ['--e10s', 14:07:49 INFO - '--xperf_path', 14:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:49 INFO - 'tests': ['tp5n']}}, 14:07:49 INFO - 'talos.zip': {'path': '', 14:07:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:49 INFO - Running post-action listener: _resource_record_post_action 14:07:49 INFO - ##### 14:07:49 INFO - ##### Running create-virtualenv step. 14:07:49 INFO - ##### 14:07:49 INFO - Running pre-action listener: _resource_record_pre_action 14:07:49 INFO - Running main action method: create_virtualenv 14:07:49 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:07:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:49 INFO - Using real prefix '/usr' 14:07:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:51 INFO - Installing pip.................done. 14:07:51 INFO - Return code: 0 14:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:07:51 INFO - Using env: {'DISPLAY': ':0', 14:07:51 INFO - 'HOME': '/home/cltbld', 14:07:51 INFO - 'LANG': 'en_US.UTF-8', 14:07:51 INFO - 'LANGUAGE': 'en_US:en', 14:07:51 INFO - 'LOGNAME': 'cltbld', 14:07:51 INFO - 'MAIL': '/var/mail/cltbld', 14:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:51 INFO - 'MOZ_NO_REMOTE': '1', 14:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:51 INFO - 'NO_EM_RESTART': '1', 14:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:51 INFO - 'PWD': '/builds/slave/test', 14:07:51 INFO - 'SHELL': '/bin/bash', 14:07:51 INFO - 'SHLVL': '1', 14:07:51 INFO - 'TERM': 'linux', 14:07:51 INFO - 'TMOUT': '86400', 14:07:51 INFO - 'USER': 'cltbld', 14:07:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:51 INFO - '_': '/tools/buildbot/bin/python'} 14:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:07:51 INFO - Cleaning up... 14:07:51 INFO - Return code: 0 14:07:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:07:51 INFO - Using env: {'DISPLAY': ':0', 14:07:51 INFO - 'HOME': '/home/cltbld', 14:07:51 INFO - 'LANG': 'en_US.UTF-8', 14:07:51 INFO - 'LANGUAGE': 'en_US:en', 14:07:51 INFO - 'LOGNAME': 'cltbld', 14:07:51 INFO - 'MAIL': '/var/mail/cltbld', 14:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:51 INFO - 'MOZ_NO_REMOTE': '1', 14:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:51 INFO - 'NO_EM_RESTART': '1', 14:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:51 INFO - 'PWD': '/builds/slave/test', 14:07:51 INFO - 'SHELL': '/bin/bash', 14:07:51 INFO - 'SHLVL': '1', 14:07:51 INFO - 'TERM': 'linux', 14:07:51 INFO - 'TMOUT': '86400', 14:07:51 INFO - 'USER': 'cltbld', 14:07:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:51 INFO - '_': '/tools/buildbot/bin/python'} 14:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:52 INFO - Downloading/unpacking psutil>=0.7.1 14:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:07:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:53 INFO - Installing collected packages: psutil 14:07:53 INFO - Running setup.py install for psutil 14:07:54 INFO - building 'psutil._psutil_linux' extension 14:07:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:07:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:07:54 INFO - building 'psutil._psutil_posix' extension 14:07:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:07:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:54 INFO - Successfully installed psutil 14:07:54 INFO - Cleaning up... 14:07:54 INFO - Return code: 0 14:07:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:54 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:07:54 INFO - Using env: {'DISPLAY': ':0', 14:07:54 INFO - 'HOME': '/home/cltbld', 14:07:54 INFO - 'LANG': 'en_US.UTF-8', 14:07:54 INFO - 'LANGUAGE': 'en_US:en', 14:07:54 INFO - 'LOGNAME': 'cltbld', 14:07:54 INFO - 'MAIL': '/var/mail/cltbld', 14:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:54 INFO - 'MOZ_NO_REMOTE': '1', 14:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:54 INFO - 'NO_EM_RESTART': '1', 14:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:54 INFO - 'PWD': '/builds/slave/test', 14:07:54 INFO - 'SHELL': '/bin/bash', 14:07:54 INFO - 'SHLVL': '1', 14:07:54 INFO - 'TERM': 'linux', 14:07:54 INFO - 'TMOUT': '86400', 14:07:54 INFO - 'USER': 'cltbld', 14:07:54 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:54 INFO - '_': '/tools/buildbot/bin/python'} 14:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:07:56 INFO - Installing collected packages: mozsystemmonitor 14:07:56 INFO - Running setup.py install for mozsystemmonitor 14:07:56 INFO - Successfully installed mozsystemmonitor 14:07:56 INFO - Cleaning up... 14:07:56 INFO - Return code: 0 14:07:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:56 INFO - Using env: {'DISPLAY': ':0', 14:07:56 INFO - 'HOME': '/home/cltbld', 14:07:56 INFO - 'LANG': 'en_US.UTF-8', 14:07:56 INFO - 'LANGUAGE': 'en_US:en', 14:07:56 INFO - 'LOGNAME': 'cltbld', 14:07:56 INFO - 'MAIL': '/var/mail/cltbld', 14:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:56 INFO - 'MOZ_NO_REMOTE': '1', 14:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:56 INFO - 'NO_EM_RESTART': '1', 14:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:56 INFO - 'PWD': '/builds/slave/test', 14:07:56 INFO - 'SHELL': '/bin/bash', 14:07:56 INFO - 'SHLVL': '1', 14:07:56 INFO - 'TERM': 'linux', 14:07:56 INFO - 'TMOUT': '86400', 14:07:56 INFO - 'USER': 'cltbld', 14:07:56 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:56 INFO - '_': '/tools/buildbot/bin/python'} 14:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:56 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:59 INFO - Downloading docopt-0.6.1.tar.gz 14:07:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:59 INFO - Running setup.py install for blobuploader 14:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:59 INFO - Running setup.py install for requests 14:07:59 INFO - Running setup.py install for docopt 14:07:59 INFO - Successfully installed blobuploader requests docopt 14:07:59 INFO - Cleaning up... 14:07:59 INFO - Return code: 0 14:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:59 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:59 INFO - Using env: {'DISPLAY': ':0', 14:07:59 INFO - 'HOME': '/home/cltbld', 14:07:59 INFO - 'LANG': 'en_US.UTF-8', 14:07:59 INFO - 'LANGUAGE': 'en_US:en', 14:07:59 INFO - 'LOGNAME': 'cltbld', 14:07:59 INFO - 'MAIL': '/var/mail/cltbld', 14:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:59 INFO - 'MOZ_NO_REMOTE': '1', 14:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:59 INFO - 'NO_EM_RESTART': '1', 14:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:59 INFO - 'PWD': '/builds/slave/test', 14:07:59 INFO - 'SHELL': '/bin/bash', 14:07:59 INFO - 'SHLVL': '1', 14:07:59 INFO - 'TERM': 'linux', 14:07:59 INFO - 'TMOUT': '86400', 14:07:59 INFO - 'USER': 'cltbld', 14:07:59 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:59 INFO - '_': '/tools/buildbot/bin/python'} 14:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:00 INFO - Running setup.py (path:/tmp/pip-TWrNHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:00 INFO - Running setup.py (path:/tmp/pip-IlCyo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:00 INFO - Running setup.py (path:/tmp/pip-THyUtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:00 INFO - Running setup.py (path:/tmp/pip-s3t6Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:00 INFO - Running setup.py (path:/tmp/pip-SFA7DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:00 INFO - Running setup.py (path:/tmp/pip-PANIkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:00 INFO - Running setup.py (path:/tmp/pip-c0n2SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:00 INFO - Running setup.py (path:/tmp/pip-NzZUTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:00 INFO - Running setup.py (path:/tmp/pip-sRFVq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:00 INFO - Running setup.py (path:/tmp/pip-njozeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:00 INFO - Running setup.py (path:/tmp/pip-OcPMRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:00 INFO - Running setup.py (path:/tmp/pip-i6OBlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:00 INFO - Running setup.py (path:/tmp/pip-cVDBQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:00 INFO - Running setup.py (path:/tmp/pip-_h2kyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:01 INFO - Running setup.py (path:/tmp/pip-ZH5qjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:01 INFO - Running setup.py (path:/tmp/pip-0kk0JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:01 INFO - Running setup.py (path:/tmp/pip-EPWBWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:01 INFO - Running setup.py install for manifestparser 14:08:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozcrash 14:08:01 INFO - Running setup.py install for mozdebug 14:08:01 INFO - Running setup.py install for mozdevice 14:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozfile 14:08:01 INFO - Running setup.py install for mozhttpd 14:08:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozinfo 14:08:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozInstall 14:08:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozleak 14:08:02 INFO - Running setup.py install for mozlog 14:08:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for moznetwork 14:08:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozprocess 14:08:02 INFO - Running setup.py install for mozprofile 14:08:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozrunner 14:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozscreenshot 14:08:02 INFO - Running setup.py install for moztest 14:08:02 INFO - Running setup.py install for mozversion 14:08:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:02 INFO - Cleaning up... 14:08:03 INFO - Return code: 0 14:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:03 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:08:03 INFO - Using env: {'DISPLAY': ':0', 14:08:03 INFO - 'HOME': '/home/cltbld', 14:08:03 INFO - 'LANG': 'en_US.UTF-8', 14:08:03 INFO - 'LANGUAGE': 'en_US:en', 14:08:03 INFO - 'LOGNAME': 'cltbld', 14:08:03 INFO - 'MAIL': '/var/mail/cltbld', 14:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:03 INFO - 'MOZ_NO_REMOTE': '1', 14:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:03 INFO - 'NO_EM_RESTART': '1', 14:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:03 INFO - 'PWD': '/builds/slave/test', 14:08:03 INFO - 'SHELL': '/bin/bash', 14:08:03 INFO - 'SHLVL': '1', 14:08:03 INFO - 'TERM': 'linux', 14:08:03 INFO - 'TMOUT': '86400', 14:08:03 INFO - 'USER': 'cltbld', 14:08:03 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:03 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:03 INFO - Running setup.py (path:/tmp/pip-GIJEi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:03 INFO - Running setup.py (path:/tmp/pip-flJRzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:03 INFO - Running setup.py (path:/tmp/pip-lYbx7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:03 INFO - Running setup.py (path:/tmp/pip-yFAE8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:03 INFO - Running setup.py (path:/tmp/pip-Uk6It4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:03 INFO - Running setup.py (path:/tmp/pip-gqYB36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:03 INFO - Running setup.py (path:/tmp/pip-dEdgHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:03 INFO - Running setup.py (path:/tmp/pip-LhQXkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:03 INFO - Running setup.py (path:/tmp/pip-wkrhax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:03 INFO - Running setup.py (path:/tmp/pip-pJxUGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:03 INFO - Running setup.py (path:/tmp/pip-8PnoR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:04 INFO - Running setup.py (path:/tmp/pip-saJus4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:04 INFO - Running setup.py (path:/tmp/pip-5erOm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:04 INFO - Running setup.py (path:/tmp/pip-P3j4bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:04 INFO - Running setup.py (path:/tmp/pip-lyhrql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:04 INFO - Running setup.py (path:/tmp/pip-E6AN5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:04 INFO - Running setup.py (path:/tmp/pip-IK8IsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:06 INFO - Downloading blessings-1.5.1.tar.gz 14:08:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:06 INFO - Installing collected packages: blessings 14:08:06 INFO - Running setup.py install for blessings 14:08:06 INFO - Successfully installed blessings 14:08:06 INFO - Cleaning up... 14:08:06 INFO - Return code: 0 14:08:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:06 INFO - Reading from file tmpfile_stdout 14:08:06 INFO - Current package versions: 14:08:06 INFO - argparse == 1.2.1 14:08:06 INFO - blessings == 1.5.1 14:08:06 INFO - blobuploader == 1.2.4 14:08:06 INFO - docopt == 0.6.1 14:08:06 INFO - manifestparser == 1.1 14:08:06 INFO - mozInstall == 1.12 14:08:06 INFO - mozcrash == 0.16 14:08:06 INFO - mozdebug == 0.1 14:08:06 INFO - mozdevice == 0.47 14:08:06 INFO - mozfile == 1.2 14:08:06 INFO - mozhttpd == 0.7 14:08:06 INFO - mozinfo == 0.9 14:08:06 INFO - mozleak == 0.1 14:08:06 INFO - mozlog == 3.1 14:08:06 INFO - moznetwork == 0.27 14:08:06 INFO - mozprocess == 0.22 14:08:06 INFO - mozprofile == 0.27 14:08:06 INFO - mozrunner == 6.11 14:08:06 INFO - mozscreenshot == 0.1 14:08:06 INFO - mozsystemmonitor == 0.0 14:08:06 INFO - moztest == 0.7 14:08:06 INFO - mozversion == 1.4 14:08:06 INFO - psutil == 3.1.1 14:08:06 INFO - requests == 1.2.3 14:08:06 INFO - wsgiref == 0.1.2 14:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:08:06 INFO - Using env: {'DISPLAY': ':0', 14:08:06 INFO - 'HOME': '/home/cltbld', 14:08:06 INFO - 'LANG': 'en_US.UTF-8', 14:08:06 INFO - 'LANGUAGE': 'en_US:en', 14:08:06 INFO - 'LOGNAME': 'cltbld', 14:08:06 INFO - 'MAIL': '/var/mail/cltbld', 14:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:06 INFO - 'MOZ_NO_REMOTE': '1', 14:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:06 INFO - 'NO_EM_RESTART': '1', 14:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:06 INFO - 'PWD': '/builds/slave/test', 14:08:06 INFO - 'SHELL': '/bin/bash', 14:08:06 INFO - 'SHLVL': '1', 14:08:06 INFO - 'TERM': 'linux', 14:08:06 INFO - 'TMOUT': '86400', 14:08:06 INFO - 'USER': 'cltbld', 14:08:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:06 INFO - '_': '/tools/buildbot/bin/python'} 14:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:08:06 INFO - Cleaning up... 14:08:06 INFO - Return code: 0 14:08:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 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 0x28da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:08:06 INFO - Using env: {'DISPLAY': ':0', 14:08:06 INFO - 'HOME': '/home/cltbld', 14:08:06 INFO - 'LANG': 'en_US.UTF-8', 14:08:06 INFO - 'LANGUAGE': 'en_US:en', 14:08:06 INFO - 'LOGNAME': 'cltbld', 14:08:06 INFO - 'MAIL': '/var/mail/cltbld', 14:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:06 INFO - 'MOZ_NO_REMOTE': '1', 14:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:06 INFO - 'NO_EM_RESTART': '1', 14:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:06 INFO - 'PWD': '/builds/slave/test', 14:08:06 INFO - 'SHELL': '/bin/bash', 14:08:06 INFO - 'SHLVL': '1', 14:08:06 INFO - 'TERM': 'linux', 14:08:06 INFO - 'TMOUT': '86400', 14:08:06 INFO - 'USER': 'cltbld', 14:08:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:06 INFO - '_': '/tools/buildbot/bin/python'} 14:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:07 INFO - Downloading/unpacking jsonschema 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:08:08 INFO - Downloading/unpacking functools32 (from jsonschema) 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:08 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:08 INFO - warning: no files found matching '*.txt' 14:08:08 INFO - no previously-included directories found matching 'build' 14:08:08 INFO - no previously-included directories found matching 'dist' 14:08:08 INFO - no previously-included directories found matching '.git*' 14:08:08 INFO - Installing collected packages: jsonschema, functools32 14:08:09 INFO - Running setup.py install for functools32 14:08:09 INFO - warning: no files found matching '*.txt' 14:08:09 INFO - no previously-included directories found matching 'build' 14:08:09 INFO - no previously-included directories found matching 'dist' 14:08:09 INFO - no previously-included directories found matching '.git*' 14:08:09 INFO - Successfully installed jsonschema functools32 14:08:09 INFO - Cleaning up... 14:08:09 INFO - Return code: 0 14:08:09 INFO - Running post-action listener: _resource_record_post_action 14:08:09 INFO - Running post-action listener: _start_resource_monitoring 14:08:09 INFO - Starting resource monitoring. 14:08:09 INFO - ##### 14:08:09 INFO - ##### Running install step. 14:08:09 INFO - ##### 14:08:09 INFO - Running pre-action listener: _resource_record_pre_action 14:08:09 INFO - Running main action method: install 14:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:09 INFO - Reading from file tmpfile_stdout 14:08:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:09 INFO - Reading from file tmpfile_stdout 14:08:09 INFO - Output received: 14:08:09 INFO - Usage: mozinstall [options] installer 14:08:09 INFO - Options: 14:08:09 INFO - -h, --help show this help message and exit 14:08:09 INFO - -d DEST, --destination=DEST 14:08:09 INFO - Directory to install application into. [default: 14:08:09 INFO - "/builds/slave/test"] 14:08:09 INFO - --app=APP Application being installed. [default: firefox] 14:08:09 INFO - mkdir: /builds/slave/test/build/application 14:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:08:24 INFO - Reading from file tmpfile_stdout 14:08:24 INFO - Output received: 14:08:24 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:24 INFO - Running post-action listener: _resource_record_post_action 14:08:24 INFO - ##### 14:08:24 INFO - ##### Running run-tests step. 14:08:24 INFO - ##### 14:08:24 INFO - Running pre-action listener: _resource_record_pre_action 14:08:24 INFO - Running main action method: run_tests 14:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:24 INFO - Python 2.7.3 14:08:24 INFO - Return code: 0 14:08:24 INFO - grabbing minidump binary from tooltool 14:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d220>, '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 0x2b092b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b09740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:08:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:08:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:24 INFO - Return code: 0 14:08:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test/build 14:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 14:08:24 INFO - Using env: {'DISPLAY': ':0', 14:08:24 INFO - 'HOME': '/home/cltbld', 14:08:24 INFO - 'LANG': 'en_US.UTF-8', 14:08:24 INFO - 'LANGUAGE': 'en_US:en', 14:08:24 INFO - 'LOGNAME': 'cltbld', 14:08:24 INFO - 'MAIL': '/var/mail/cltbld', 14:08:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:24 INFO - 'MOZ_NO_REMOTE': '1', 14:08:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:24 INFO - 'NO_EM_RESTART': '1', 14:08:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:24 INFO - 'PWD': '/builds/slave/test', 14:08:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:24 INFO - 'SHELL': '/bin/bash', 14:08:24 INFO - 'SHLVL': '1', 14:08:24 INFO - 'TERM': 'linux', 14:08:24 INFO - 'TMOUT': '86400', 14:08:24 INFO - 'USER': 'cltbld', 14:08:24 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301', 14:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:24 INFO - '_': '/tools/buildbot/bin/python'} 14:08:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 14:08:24 INFO - mozversion INFO | application_buildid: 20151125130231 14:08:24 INFO - mozversion INFO | application_changeset: ffcf2bb8b1b43b4970e0efeca19643e5e5d78325 14:08:24 INFO - mozversion INFO | application_display_name: Nightly 14:08:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:24 INFO - mozversion INFO | application_name: Firefox 14:08:24 INFO - mozversion INFO | application_remotingname: firefox 14:08:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 14:08:24 INFO - mozversion INFO | application_vendor: Mozilla 14:08:24 INFO - mozversion INFO | application_version: 45.0a1 14:08:24 INFO - mozversion INFO | platform_buildid: 20151125130231 14:08:24 INFO - mozversion INFO | platform_changeset: ffcf2bb8b1b43b4970e0efeca19643e5e5d78325 14:08:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 14:08:24 INFO - mozversion INFO | platform_version: 45.0a1 14:08:24 INFO - 2015-11-25 14:08:24,942 DEBUG : using testdate: 1448489304 14:08:24 INFO - 2015-11-25 14:08:24,942 DEBUG : actual date: 1448489304 14:08:24 INFO - 2015-11-25 14:08:24,950 INFO : starting webserver on 'localhost:44143' 14:08:24 INFO - 2015-11-25 14:08:24,951 INFO : Starting test suite talos-linux64-ix-054 14:08:24 INFO - 2015-11-25 14:08:24,951 INFO : Starting test dromaeo_css 14:08:24 INFO - 2015-11-25 14:08:24,952 DEBUG : operating with platform_type : linux_ 14:08:24 INFO - 2015-11-25 14:08:24,952 INFO : Initialising browser for dromaeo_css test... 14:08:24 INFO - 2015-11-25 14:08:24,969 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2Ppgf/profile http://localhost:44143/getInfo.html 14:08:29 INFO - 2015-11-25 14:08:29,125 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:08:29 INFO - 2015-11-25 14:08:29,125 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:08:29 INFO - 2015-11-25 14:08:29,125 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:08:29 INFO - 2015-11-25 14:08:29,125 DEBUG : BROWSER_OUTPUT: __metrics 14:08:29 INFO - 2015-11-25 14:08:29,266 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:30 INFO - 2015-11-25 14:08:30,539 INFO : Browser initialized. 14:08:30 INFO - 2015-11-25 14:08:30,540 INFO : Running cycle 1/1 for dromaeo_css test... 14:08:30 INFO - 2015-11-25 14:08:30,540 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2Ppgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:08:42 INFO - 2015-11-25 14:08:42,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 147308544 14:08:42 INFO - 2015-11-25 14:08:42,409 DEBUG : BROWSER_OUTPUT: 14:09:33 INFO - 2015-11-25 14:09:33,663 DEBUG : BROWSER_OUTPUT: 1448489373658 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:11:45 INFO - 2015-11-25 14:11:45,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44143/tests/dromaeo/cssquery-ext.html) 14:11:46 INFO - 2015-11-25 14:11:46,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 265764864 14:11:46 INFO - 2015-11-25 14:11:46,877 DEBUG : BROWSER_OUTPUT: 14:14:49 INFO - 2015-11-25 14:14:49,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-ext.html (next: http://localhost:44143/tests/dromaeo/cssquery-jquery.html) 14:14:49 INFO - 2015-11-25 14:14:49,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 231215104 14:14:49 INFO - 2015-11-25 14:14:49,948 DEBUG : BROWSER_OUTPUT: 14:17:51 INFO - 2015-11-25 14:17:51,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44143/tests/dromaeo/cssquery-mootools.html) 14:17:52 INFO - 2015-11-25 14:17:52,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 224718848 14:17:52 INFO - 2015-11-25 14:17:52,529 DEBUG : BROWSER_OUTPUT: 14:20:54 INFO - 2015-11-25 14:20:54,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44143/tests/dromaeo/cssquery-prototype.html) 14:20:54 INFO - 2015-11-25 14:20:54,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 211931136 14:20:54 INFO - 2015-11-25 14:20:54,969 DEBUG : BROWSER_OUTPUT: 14:23:57 INFO - 2015-11-25 14:23:57,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44143/tests/dromaeo/cssquery-yui.html) 14:23:58 INFO - 2015-11-25 14:23:58,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 216354816 14:23:58 INFO - 2015-11-25 14:23:58,356 DEBUG : BROWSER_OUTPUT: 14:27:00 INFO - 2015-11-25 14:27:00,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/dromaeo/cssquery-yui.html (next: http://localhost:44143/tests/dromaeo/cssquery-dojo.html) 14:27:01 INFO - 2015-11-25 14:27:01,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 283164672 14:27:01 INFO - 2015-11-25 14:27:01,108 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,108 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:27:01 INFO - 2015-11-25 14:27:01,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:27:01 INFO - 2015-11-25 14:27:01,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:27:01 INFO - 2015-11-25 14:27:01,109 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:27:01 INFO - 2015-11-25 14:27:01,109 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.093307808806;2711.308616302844;2714.0772137473255;2738.9999999999986;2747.354371722645;4490.348899409583;4574.862754117374;4627.282771170466;4663.300504924259;4664.277037059257;4556.589906908378;4557.065801510691;4647.651426143045;4650.465196502403;4677.953220467794;4269.274223382033;4280.828766849322;4281.207976524337;4329.891752706176;4338.370936214247;4133.111381053073;4400.669949753766;4401.449818772653;4446.533114023029;4453.109378124388;4250.532441431471;4265.850695225652;4289.656827453828;4316.158349121923;4351.6953813233085;4304.246756817575;4322.459692538433;4326.8269269229195;4327.459067616548;4364.5635436456105;4112.753234805891;4223.831046758126;4290.184864875695;4308.82764689412;4358.3244597087505;4465.24090904547;4566.520515345907;4634.768261586907;4656.254999200146;4686.742229177394;5077.720725360104;5091.694498330075;5097.974510127463;5118.820841270538;5144.356955380577;4841.298011788306;4957.7769000395065;5105.770240339194;5118.513741194581;5138.58891288696;4620.768961551943;4672.112298663243;4672.369230153954;4682;4742.004179122354;5203;5229.4770522948165;5230.293910322134;5233.973830130825;5255.947440525546;4701.412323459567;4804.615630749532;5016.197408414636;5020.849374518771;5072.137736584789;4929.211326187793;4994;5069.771860266297;5074.238864170404;5093.1087059764395;5046.6719663221775;5058.165402708585;5063.772130254148;5064.848054558369;5111;4781.067691800135;4921;5002.174641184237;5003.24951257307;5013.24801279811;4193.832246710097;4210.0948296116485;4241.300185469425;4260.723053001607;4280.293751531025;3698.334299826003;3707.14735610811;3728.2729867675544;3738.36447803874;3766.077311058808;4127.236461254677;4410.889727756832;4416.757078360657;4423.60187583119;4462.843800466968;4999.275105109738;5013.724245166551;5020.196768517019;5086.64393492452;5144.61415393847;4366.934495982563;4372.956270437318;4393.956060439355;4397.934030989538;4432;4279.443672322641;4563.201439748097;4563.771811409416;4567.200739870509;4604.930926036112;4658.906821863544;4681.976590117096;4696.365990591226;4742.691725037862;4791.401074865642;5079.568236699922;5154.304168937146;5154.458781827854;5172.689638621695;5213.45258747826;4581.266997280419;4877.097736918681;4897.289892965571;4899.583535399531;4946.8763280918265;4869.31829543857;4879.194932836042;4909.214525676018;4941.085899108676;5005.524475174852;5058;5086.872828179177;5088.6946783193125;5089.465606111453;5136.768845402041;4646.465656449416;4915.582175515121;4915.877103072452;4924.285978533021;4967.751612419437;4819.2530157825595;4821.54195351441;4842.830500932591;4874.8537543873745;4890.168671325954;4840.273958906192;4845.5881250094135;4863.878403039952;4867.172580661225;4913.140200464976;4713.3636959011465;4974.801007959641;4990.975045124751;4991.9500804991485;5034.395872495324;4663.883402914954;4714.646401519968;4763.976180119077;4827.131116399082;4894.241392584155 14:27:01 INFO - 2015-11-25 14:27:01,110 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.5626854784717;562.9240052592899;574.1330590807879;576.3861487515795;583.7694110826222;27227.319317017085;27690.861545692267;36172.81913590435;36771.63228367716;36799.63200367995;40337.39493907594;40811.79594102025;40857.59142408575;40914.7954260229;40929.795351023204;6909.689063992108;7913.446058775902;8086.110527841962;8097.757067287961;8099.797505062362;6916.65416729164;10296.639617613386;10553;10560.47197640115;10572.418516981563;10278.691639250797;10368.222383321281;10369.274150809446;10381.273310868242;10383.636572719955;6980.162380514371;7144.285571442866;10076.445795481246;10097.343672661253;10180.847287290733;10084.647037353658;10218.029287217703;10218.489075546267;10221.233407494394;10232.232582556338;38438.423423648666;38968.22063558713;39038.60961390378;39078.41382379267;39087.41368879469;2970.0941212930047;2971.227480854972;2974.628171478565;2995.65549961755;3563.002359339389;28471.492134988348;28858.567121493194;28906.855465722747;28984.565231521545;29567.40865182684;3430.4168291390524;3492;3503.1242189452637;3561.626029266916;3620.4026335654585;224145;224586;225758;226421;226965;51628.48371516312;53220;57329.713351432976;58192.4180758187;63517;57426.71286643624;57589.13616295759;57666.711666442236;57801.421985779605;57811;12894;12997.935010325076;12998.350082495837;13009.739805203842;13031.543895963596;9959.80080398388;10035.648752293635;10036.598536058622;10042.096211341015;10054.547545360476;19108.2356705733;19313.4205973821;19339.80660193408;19384.515387115436;19399.709004364944;6898.448124150156;7043.0983634419445;7092.078029856086;7116.395106416013;7125.35871771543;783.2715574515755;881.1628952495155;936.2182577547824;943.4150826487485;1014.5333146752429;25963.610545841828;26280.34299142537;26838;29054.273643158667;29485.557716634266;875.5622188905547;914.71001005285;931.5994122527243;945.3382632157517;1021.8927012663563;13351.465941362238;13413.329333533284;13428.73907292673;13536.593902182753;13619.182849028892;265197;269150;270891;270947;271615;45354;45573.7721311398;45605.31592026122;45626.31560526595;45628.08743825105;1206.4691535724253;1208.305732230274;1211.0674780419029;1211.2913945342073;1220.3105245536244;25061.624075638516;25489.36276593026;25667.486650266517;26203.475930481665;26351;40767.59232407638;41037.38443923403;41296.79351603223;41303.38044929389;41333;247728;250084;251782;251961;252467;23367.182148624717;24321.39196520101;25316.493670126863;28270.43459130847;29403.411931760817;32462;36549.26901462009;37167;37195.62804371922;37577.4363384544;31308.843455782575;31429.68570314359;32013.519797203528;32457.675423245466;32759.67240327566;31909.840450797597;32001.519977200827;32228.35543289168;32512.187195320304;32737.672623274415;31959.201019974687;32116.839415802773;32125.35749285048;32346.191345216557;32396.676033239364;28081.43837123287;29071.854640726662;29187.124386268446;29203;29303.413931721672;22691.546169076195;22829;23047.769522304563;23052;23132.190373336853 14:27:01 INFO - 2015-11-25 14:27:01,112 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.0181958672948;333.2934179539377;336.84085015053506;336.92924485857986;341.11140479052085;12269.447874845631;12685.492580296777;15045.322960466778;15266.542003739878;16044.759328610065;13648.11287266327;14137.646558836033;14635.268236588181;15233.390664373439;15273.77089343658;4877.292792545079;4944.33251511045;4961.603071754251;4962.354893863792;5055.620828437864;3539.5929468111112;3605.513255710485;5686.232358631594;5823.505002074808;5828.591998560102;5755.913661295084;5761.222234998263;5775.3358363788075;5777.306723193223;5806.854828629276;5121.359830021247;5262.789488420459;5268.5521730652945;5274.657147285433;5275;4882.658213925027;5069.619778516626;5072.873178170538;5076.314697515825;5090.440051594322;12135.757284854253;12300;12329.5068197272;12349.567765128177;16538;1725.7325114607256;1764.250193667686;1799.973000404995;1856.303886042734;1938.1375287996848;9274.629014839398;9346.859797103049;11015.118790496741;11729.06167506606;13019.088663793538;1727.8963262204181;1729.2132079903613;1736.748171515136;1793.390247315919;1793.8698619869529;54521.72739136279;55660.16509752317;56312.71843640756;56540.71729641366;57806.42193578053;9723.708288751348;9796.040791841519;9843.064908833649;9847.901520984842;9889.752756181153;12398.876011239772;12408.56570020045;12411.131220814455;12442.315672638091;12461.626151215296;6311.558190926591;8019.077806052262;8157.306628936488;8174.100848906615;8194.877076843852;6510.609363438209;6587.176602924635;6654.600723956578;6815.42068924147;7156.749513767098;7406.148292946273;7434.442416818761;7509.699612015567;7516.060492438445;7580.9620951894885;2405.807535397164;2927.5315949448413;2966.3029188140767;3013.032163319129;3075.1082186165763;796.0010187215124;799.6761311668783;857.7469646454311;866.787637028932;945.1304799584399;15842.841571584137;16117.113558754381;16317.265723042492;16446.259918303705;16572.668546629;814.7352110563971;862.905080441151;893.946363218209;910.8679241510076;959.194276807485;8387.287080598218;8937.240334571505;8940.15068568485;9129.543522823833;9282.396644218104;482635;511596;519393;526814;528690;74653.62673186707;75522;75740.62129689427;76590;78241.60879195567;1065.9606883288732;1066.6906597086759;1068.3056013591072;1075.7848430313968;1087.1683162380784;14613.342399592257;14713.92643036778;14838.18389988561;14851;14908.403663853325;33370.33259334848;33868.153296167795;34298.82850585731;35053;35196.47205291974;42385.5761442394;43273.78363108164;43617.12765744731;44339.55660443354;45438.54561454343;8928.776780580538;8944.86582701247;9071.59177837012;9171.44971301724;9200.907990920005;10746.570137194738;11279.830802538132;15311.15788631636;16684.165791710122;16707.49877503677;12948.15836970594;13012.154209976321;13333;13333.799992999919;13353.39909704085;13118.737625247633;13146.27695476758;13238.139520931109;13341.19952802835;13353.53262635803;13282.402291896695;13408.731825363244;13576.456941722221;13858.16850988944;14151.929240353733;8964.86552701697;9148.268138549034;9179.678711245075;9193.816123677356;9280.628774849201;14096;14153.455551643698;14456.710865782836;14523.85476145225;14637.707245855236 14:27:01 INFO - 2015-11-25 14:27:01,115 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1366.5763613279878;1590.3559058581272;1637.6560922206336;1653.5436997292295;1662.2270644150467;5718.485336319731;6573.211214654242;6848.691808868601;6859.897101543468;6874.140732408443;6797.218319893202;6888.75889343873;6917.792466226008;6927.4458043356535;6949.89575156373;1700.472853415439;1724.4136993422235;1728.3173146607082;2028.2698228637641;2055.434755442258;2030.4416285521527;2085.1242478159133;2085.655866781979;2086.968695469569;2087.2485905074163;1983.5735316906862;2024.7266619006466;2031.6546187148147;2032.3191730770209;2032.4207600833765;2048.7541495020546;2079.563291708743;2106.347032419947;2106.8841213733162;2107.2308607358204;2091.393495886191;2117.1213946212456;2118.4492032071616;2120.8409369297365;2121.1197353098446;6877.312268773133;6942.757003504853;6947.652617369111;6953.374196322356;6956.930430695729;4078.490188726409;4181.644560212386;4211.031462763582;4213.810378532973;4215.241256573816;2664.706882242952;2770.293575138347;2784.3456787654886;2811.9297017574518;2820.2667306500252;742.8922806193126;883.1654086887894;894.6555576103248;904.9819003619957;931.8136372725414;9037.141471560257;9182.08179182083;9190.908090919072;9219.723408297761;9223.123803238748;3986.661133803659;4003.979980100081;4038.1318016626565;4078.021274894004;4080.4491393661474;8002.439829211899;8018.318442932299;8038.236367545074;8056.879146812803;8082.19178082187;4099.651529620016;4139.875803725893;4143.627073563393;4148.854790082393;4152.045029643199;3776.244751049801;3778.3387907116694;3778.848846046182;3779.848806047727;3781.5084039074745;3393.8642454302044;3400.6939375456327;3426.3318652862454;3432.639572844865;3451.81015044175;1083.5394957143183;1084.4740300954031;1087.6193332333619;1090.0734375780523;1096.8628921384827;789.1201310538708;800.703739616334;801.0187520287601;802.4703695560902;906.795970906554;6300.684965751694;6349.142865713162;6349.396807303298;6353.36466353361;6362.586431881913;432.675493379965;440.79723327269176;444.6576136375038;446.33050424363455;448.83617479619704;4947.356843610308;4951.529604687549;5011.847275126668;5022.924656130161;5023.623228257895;7980.162082981204;7994.360451163893;8219.465734727224;8285.461445006054;8311.625976831057;8191.918080819235;8194.385421093442;8197.426180167331;8210.220029097227;8222.136675648972;6378.617282963037;6417.679116044273;6495.350464953562;6496.480281577463;6578.5395022347975;6061.939380606137;6131.294901086254;6132.325444201045;6136.662483563268;6139.6009259398;7123.536970096927;7360.77917662471;7377.225391333833;7386.519876208029;7414.369778568882;7406.666699998621;7576.128745194374;7588.27911348421;7600.923990760021;7642.8089297768;6025.939740602538;6030.698465076816;6063.302720187235;6079.209702738615;6080.787172448943;6310.495160387066;6322.209723784527;6382.170317858649;6424.486041116793;6446.194225721785;6084.482818960438;6089.147519347206;6162;6180.196574445294;6204.72078756448;6048.274207095177;6073.757049718139;6074.544409169242;6138.907916381168;6194.132821405097;5947.524198064058;5987.072003839412;6002.219711437485;6059.303180134341;6065.4541091302;5661.320641523043;5692.743826527733;5707.600467967369;5720.856978575569;5722.7710891563875;4924.532169443897;5613.186088017296;5663.207150998781;5664.716764161858;5692.914606280992 14:27:01 INFO - 2015-11-25 14:27:01,115 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.43694505308025;318.7402267152271;320.5576304699515;322.89505910579066;324.68829923273654;5268.710220937856;5408.350997880255;5443.1835224716315;5474.069408200606;5505.944940550593;5237.685738855671;5372.677639341642;5394.676319420838;5398.973005134969;5409.323109835944;4265;4269.679774016946;4271.359296105586;4274.230638485072;4283.32950149442;4025.235205310996;4088.4684990951137;4097.13960068386;4100.733452325604;4264.594863487963;4054.6350828425434;4063.1061166543313;4094.733842300241;4166.916661666764;4191.287481128215;4198.538160802309;4209.347551129596;4216.97891510542;4223.260929337384;4224.831006759726;3681.8402203305873;3712.6844218241213;3726.087108658396;3734.514513113305;3739.326921154191;5059.620528460343;5229.973850130763;5230.712310822903;5240.3973543042275;5242.266082748418;4877.268409738532;4883.145449546315;4883.829065982709;4888.0957022950515;4896.804127834882;5708.115242137475;5714.057180565202;5714.7428365723645;5723.942760572382;5726.656400615976;3839.462475253467;3948.4669569608022;4002.3396139636925;4092.5498195198506;4107.301758700998;5968.253968253968;5996.97001514994;5998.940010599926;6026.638401695912;6041.72812223451;4190.811413486401;4192.182524407772;4192.769397683096;4202.810873510699;4219.156168766259;4273.423087883159;4277.443932288783;4277.828886844553;4280.892977675583;4284.935725964113;4723.622110231242;4842.15262329091;4850.417949846041;4861.659683822169;4869.70781753096;5715.085586306254;5735.598508104393;5739.081746920473;5748.252727145445;5750.971245143747;1502.6318551954623;1523.2764436892387;1523.7790520374483;1525.3136088760102;1525.7406240939067;1046.4767616191905;1051.033049594375;1052.3685788526823;1053.599632139782;1073.9194560408;5012.198048312325;5013.39839219296;5017.197248440232;5017.347744793154;5020.447750747415;5944.346121926585;5944.464998150187;5945;5948.226730525004;5951.196588460589;5012.548870601663;5014.749262536859;5015.749212539358;5016.745813546613;5017.046761115449;3141.748660107186;3183.6657150999276;3218.7103160715646;3224.596925384327;3226.1934516370907;5596.076647353222;5613.8596535086135;5615.466530679579;5615.522680572116;5624.409437009055;6093.177421048191;6093.268807743099;6095.299040610298;6096.177016102769;6097.7865774697675;5481.75332110048;5587.888242235133;5607.43925607436;5611.102223644279;5617.157426386075;5957.076653118774;5963.821085367446;5963.940360596339;5969.04495280753;5978.491828194478;5637.1262454318;5770.567207459373;5772.884542309214;5830.854228644318;5837.766489340379;5487.396386397413;5587.580931430078;5646.943530564806;5649.265595472562;5679.574031947538;4207.621314081747;4249.97875010623;4254.787260637017;4258.169656916872;4258.467691538558;5793.420657934173;5920.674362909909;5923.348431672599;5937.109433584997;5939.16851640762;5719.428057194247;5719.885602287848;5721.342045664635;5724.513416359489;5732.684702341411;5721.7425215866215;5722.341930678025;5736.42635736423;5739.942600573941;5743.023685973478;5612.186232996274;5616.073347897551;5618.915716264341;5619.550435965031;5619.578531610227;5625.437456254342;5762.683052432157;5766.192733017465;5767.394423585463;5768.855778605568;5603.411641777555;5607.943920560742;5608.439156084359;5611.466910643482;5612.831615051555 14:27:01 INFO - 2015-11-25 14:27:01,115 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.5848573884192;711.9893201601977;752.4544705088811;753.9811504712378;786.3944762532848;11458.369789661565;11619.593314234004;11652.242604230729;11663.650090497298;11669.066474682026;10196.949015254932;10658.946705266462;11054.226204165712;11308.717282067952;11443.656690299284;760.0575286644548;775.5269285735696;776.2664282253273;776.4952780692538;777.3703300326754;768.3852917665873;776.1036003416064;776.409928454376;777.0946846923327;777.9805504862395;800.1998001998002;805.3355981315439;807.7940125268049;808.4664121679692;808.6765293882436;800.4756884240802;800.4876878797545;800.5516910530064;801.4830434369799;801.7795106345743;595.5176307191145;597.1162679234714;597.3727586034646;598.308953159102;598.3418239936079;10289.948550257275;10369.325993810378;10384.532696028697;10404.427756473391;10457.058864702138;9448.291378146598;9682.515874206332;9753.21974242059;9825.164860986824;10095.394276343442;8829.205371516595;10025.498725063791;10057.798844023078;10360.844587331196;10406.583736650526;3278.7377009839156;3286.1948822538393;3307.991062725868;3311.420501412267;3404.3361544498835;34305.6569434305;34506;34738.478922816175;35615.28769424597;43190.78404607988;8846.380753347205;8979.371443998858;9392.483413412328;9494.430334179971;9587.99416382969;16229.756553651705;16241.83758162427;16271.349146034263;16271.83728162727;16277.430289939795;6425.678716064178;6479.611223326616;6516.674166291761;6522.412982831568;6675.966620166868;3587.6232995535615;3589.6410358963894;3610.693091087287;3669.1560940983723;3718.7396882217986;2760.4065125997604;2789.539725945237;2790.4140130572805;2792.2600510864636;2797.9020734274204;470.83991442909576;486.576678289883;487.61478432039;495.87850976510987;505.54753495621213;423.1135770560671;423.6039303251408;430.5350221760491;457.11548154321497;493.40298239130334;7280.8179795504475;7376.926230737731;7604.087509498895;7642.426817988673;7645.770626881203;505.2623170171591;517.8291163915899;527.4777969809937;546.0035435330537;555.4639772619441;3370.427027405347;3433.776804507699;3487.5640544931885;3616.728745344057;3626.637336266405;49007;52464.737676312136;52605.7369713149;52632.73683631558;52792.73603632034;44475.332870006976;45657;45726.77136614296;46141.769291154;46279;35872.28255434876;39996.20007599832;40065.39901901474;40550.18899621991;40855.38716919249;7595.5822429766895;7675.53946763196;7787.649555770117;8112.10766815638;8134.674613015413;31947.840260798548;32044.67955320417;32568.674313256564;32672;32806.34387312193;39897.60102399055;40759.388609170295;41159.38260926028;41210.1757964845;41288.793556033226;8770.693025744069;9598.568064437257;9712.75718107053;9721.222302215947;9725.756856078655;10810;10864;10894.564217431214;11002.779944401227;11129.10967122612;10071;10074.546645400827;10078.244131690299;10080.294379393665;10449.21630877672;10220.642277520252;10494.68515944523;10808.405537695502;10866.07638350749;10961.725956851142;10428.165746740395;10435.843462348223;10506.159507239556;10523.631672891719;10523.894761052597;8498.70254541088;8554.615042322986;8931.330150238888;8964.282857371525;9241.445513268956;8053.718119865776;8056.476329038828;8146.75559733209;8710.91289087101;8992.100789920956 14:27:01 INFO - 2015-11-25 14:27:01,115 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:27:01 INFO - 2015-11-25 14:27:01,116 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:27:01 INFO - 2015-11-25 14:27:01,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1007 14:27:01 INFO - 2015-11-25 14:27:01,116 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:27:01 INFO - 2015-11-25 14:27:01,116 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490421105__endTimestamp 14:27:01 INFO - 2015-11-25 14:27:01,116 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4649.00 Median:4714.65 stddev:489.66 (10.4%) stddev-sans-first:464.79 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: Values: 2628.1 2711.3 2714.1 2739.0 2747.4 4490.3 4574.9 4627.3 4663.3 4664.3 4556.6 4557.1 4647.7 4650.5 4678.0 4269.3 4280.8 4281.2 4329.9 4338.4 4133.1 4400.7 4401.4 4446.5 4453.1 4250.5 4265.9 4289.7 4316.2 4351.7 4304.2 4322.5 4326.8 4327.5 4364.6 4112.8 4223.8 4290.2 4308.8 4358.3 4465.2 4566.5 4634.8 4656.3 4686.7 5077.7 5091.7 5098.0 5118.8 5144.4 4841.3 4957.8 5105.8 5118.5 5138.6 4620.8 4672.1 4672.4 4682.0 4742.0 5203.0 5229.5 5230.3 5234.0 5255.9 4701.4 4804.6 5016.2 5020.8 5072.1 4929.2 4994.0 5069.8 5074.2 5093.1 5046.7 5058.2 5063.8 5064.8 5111.0 4781.1 4921.0 5002.2 5003.2 5013.2 4193.8 4210.1 4241.3 4260.7 4280.3 3698.3 3707.1 3728.3 3738.4 3766.1 4127.2 4410.9 4416.8 4423.6 4462.8 4999.3 5013.7 5020.2 5086.6 5144.6 4366.9 4373.0 4394.0 4397.9 4432.0 4279.4 4563.2 4563.8 4567.2 4604.9 4658.9 4682.0 4696.4 4742.7 4791.4 5079.6 5154.3 5154.5 5172.7 5213.5 4581.3 4877.1 4897.3 4899.6 4946.9 4869.3 4879.2 4909.2 4941.1 5005.5 5058.0 5086.9 5088.7 5089.5 5136.8 4646.5 4915.6 4915.9 4924.3 4967.8 4819.3 4821.5 4842.8 4874.9 4890.2 4840.3 4845.6 4863.9 4867.2 4913.1 4713.4 4974.8 4991.0 4992.0 5034.4 4663.9 4714.6 4764.0 4827.1 4894.2 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,117 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40910.87 Median:2970.66 stddev:64924.64 (2185.5%) stddev-sans-first:65036.05 14:27:01 INFO - 2015-11-25 14:27:01,118 DEBUG : BROWSER_OUTPUT: Values: 553.6 562.9 574.1 576.4 583.8 27227.3 27690.9 36172.8 36771.6 36799.6 40337.4 40811.8 40857.6 40914.8 40929.8 6909.7 7913.4 8086.1 8097.8 8099.8 6916.7 10296.6 10553.0 10560.5 10572.4 10278.7 10368.2 10369.3 10381.3 10383.6 6980.2 7144.3 10076.4 10097.3 10180.8 10084.6 10218.0 10218.5 10221.2 10232.2 38438.4 38968.2 39038.6 39078.4 39087.4 2970.1 2971.2 2974.6 2995.7 3563.0 28471.5 28858.6 28906.9 28984.6 29567.4 3430.4 3492.0 3503.1 3561.6 3620.4 224145.0 224586.0 225758.0 226421.0 226965.0 51628.5 53220.0 57329.7 58192.4 63517.0 57426.7 57589.1 57666.7 57801.4 57811.0 12894.0 12997.9 12998.4 13009.7 13031.5 9959.8 10035.6 10036.6 10042.1 10054.5 19108.2 19313.4 19339.8 19384.5 19399.7 6898.4 7043.1 7092.1 7116.4 7125.4 783.3 881.2 936.2 943.4 1014.5 25963.6 26280.3 26838.0 29054.3 29485.6 875.6 914.7 931.6 945.3 1021.9 13351.5 13413.3 13428.7 13536.6 13619.2 265197.0 269150.0 270891.0 270947.0 271615.0 45354.0 45573.8 45605.3 45626.3 45628.1 1206.5 1208.3 1211.1 1211.3 1220.3 25061.6 25489.4 25667.5 26203.5 26351.0 40767.6 41037.4 41296.8 41303.4 41333.0 247728.0 250084.0 251782.0 251961.0 252467.0 23367.2 24321.4 25316.5 28270.4 29403.4 32462.0 36549.3 37167.0 37195.6 37577.4 31308.8 31429.7 32013.5 32457.7 32759.7 31909.8 32001.5 32228.4 32512.2 32737.7 31959.2 32116.8 32125.4 32346.2 32396.7 28081.4 29071.9 29187.1 29203.0 29303.4 22691.5 22829.0 23047.8 23052.0 23132.2 14:27:01 INFO - 2015-11-25 14:27:01,118 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,118 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27326.01 Median:42829.68 stddev:83971.33 (196.1%) stddev-sans-first:84182.42 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: Values: 330.0 333.3 336.8 336.9 341.1 12269.4 12685.5 15045.3 15266.5 16044.8 13648.1 14137.6 14635.3 15233.4 15273.8 4877.3 4944.3 4961.6 4962.4 5055.6 3539.6 3605.5 5686.2 5823.5 5828.6 5755.9 5761.2 5775.3 5777.3 5806.9 5121.4 5262.8 5268.6 5274.7 5275.0 4882.7 5069.6 5072.9 5076.3 5090.4 12135.8 12300.0 12329.5 12349.6 16538.0 1725.7 1764.3 1800.0 1856.3 1938.1 9274.6 9346.9 11015.1 11729.1 13019.1 1727.9 1729.2 1736.7 1793.4 1793.9 54521.7 55660.2 56312.7 56540.7 57806.4 9723.7 9796.0 9843.1 9847.9 9889.8 12398.9 12408.6 12411.1 12442.3 12461.6 6311.6 8019.1 8157.3 8174.1 8194.9 6510.6 6587.2 6654.6 6815.4 7156.7 7406.1 7434.4 7509.7 7516.1 7581.0 2405.8 2927.5 2966.3 3013.0 3075.1 796.0 799.7 857.7 866.8 945.1 15842.8 16117.1 16317.3 16446.3 16572.7 814.7 862.9 893.9 910.9 959.2 8387.3 8937.2 8940.2 9129.5 9282.4 482635.0 511596.0 519393.0 526814.0 528690.0 74653.6 75522.0 75740.6 76590.0 78241.6 1066.0 1066.7 1068.3 1075.8 1087.2 14613.3 14713.9 14838.2 14851.0 14908.4 33370.3 33868.2 34298.8 35053.0 35196.5 42385.6 43273.8 43617.1 44339.6 45438.5 8928.8 8944.9 9071.6 9171.4 9200.9 10746.6 11279.8 15311.2 16684.2 16707.5 12948.2 13012.2 13333.0 13333.8 13353.4 13118.7 13146.3 13238.1 13341.2 13353.5 13282.4 13408.7 13576.5 13858.2 14151.9 8964.9 9148.3 9179.7 9193.8 9280.6 14096.0 14153.5 14456.7 14523.9 14637.7 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4777.40 Median:6039.49 stddev:2465.44 (40.8%) stddev-sans-first:2459.03 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: Values: 1366.6 1590.4 1637.7 1653.5 1662.2 5718.5 6573.2 6848.7 6859.9 6874.1 6797.2 6888.8 6917.8 6927.4 6949.9 1700.5 1724.4 1728.3 2028.3 2055.4 2030.4 2085.1 2085.7 2087.0 2087.2 1983.6 2024.7 2031.7 2032.3 2032.4 2048.8 2079.6 2106.3 2106.9 2107.2 2091.4 2117.1 2118.4 2120.8 2121.1 6877.3 6942.8 6947.7 6953.4 6956.9 4078.5 4181.6 4211.0 4213.8 4215.2 2664.7 2770.3 2784.3 2811.9 2820.3 742.9 883.2 894.7 905.0 931.8 9037.1 9182.1 9190.9 9219.7 9223.1 3986.7 4004.0 4038.1 4078.0 4080.4 8002.4 8018.3 8038.2 8056.9 8082.2 4099.7 4139.9 4143.6 4148.9 4152.0 3776.2 3778.3 3778.8 3779.8 3781.5 3393.9 3400.7 3426.3 3432.6 3451.8 1083.5 1084.5 1087.6 1090.1 1096.9 789.1 800.7 801.0 802.5 906.8 6300.7 6349.1 6349.4 6353.4 6362.6 432.7 440.8 444.7 446.3 448.8 4947.4 4951.5 5011.8 5022.9 5023.6 7980.2 7994.4 8219.5 8285.5 8311.6 8191.9 8194.4 8197.4 8210.2 8222.1 6378.6 6417.7 6495.4 6496.5 6578.5 6061.9 6131.3 6132.3 6136.7 6139.6 7123.5 7360.8 7377.2 7386.5 7414.4 7406.7 7576.1 7588.3 7600.9 7642.8 6025.9 6030.7 6063.3 6079.2 6080.8 6310.5 6322.2 6382.2 6424.5 6446.2 6084.5 6089.1 6162.0 6180.2 6204.7 6048.3 6073.8 6074.5 6138.9 6194.1 5947.5 5987.1 6002.2 6059.3 6065.5 5661.3 5692.7 5707.6 5720.9 5722.8 4924.5 5613.2 5663.2 5664.7 5692.9 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4759.74 Median:5255.49 stddev:1380.46 (26.3%) stddev-sans-first:1343.42 14:27:01 INFO - 2015-11-25 14:27:01,119 DEBUG : BROWSER_OUTPUT: Values: 315.4 318.7 320.6 322.9 324.7 5268.7 5408.4 5443.2 5474.1 5505.9 5237.7 5372.7 5394.7 5399.0 5409.3 4265.0 4269.7 4271.4 4274.2 4283.3 4025.2 4088.5 4097.1 4100.7 4264.6 4054.6 4063.1 4094.7 4166.9 4191.3 4198.5 4209.3 4217.0 4223.3 4224.8 3681.8 3712.7 3726.1 3734.5 3739.3 5059.6 5230.0 5230.7 5240.4 5242.3 4877.3 4883.1 4883.8 4888.1 4896.8 5708.1 5714.1 5714.7 5723.9 5726.7 3839.5 3948.5 4002.3 4092.5 4107.3 5968.3 5997.0 5998.9 6026.6 6041.7 4190.8 4192.2 4192.8 4202.8 4219.2 4273.4 4277.4 4277.8 4280.9 4284.9 4723.6 4842.2 4850.4 4861.7 4869.7 5715.1 5735.6 5739.1 5748.3 5751.0 1502.6 1523.3 1523.8 1525.3 1525.7 1046.5 1051.0 1052.4 1053.6 1073.9 5012.2 5013.4 5017.2 5017.3 5020.4 5944.3 5944.5 5945.0 5948.2 5951.2 5012.5 5014.7 5015.7 5016.7 5017.0 3141.7 3183.7 3218.7 3224.6 3226.2 5596.1 5613.9 5615.5 5615.5 5624.4 6093.2 6093.3 6095.3 6096.2 6097.8 5481.8 5587.9 5607.4 5611.1 5617.2 5957.1 5963.8 5963.9 5969.0 5978.5 5637.1 5770.6 5772.9 5830.9 5837.8 5487.4 5587.6 5646.9 5649.3 5679.6 4207.6 4250.0 4254.8 4258.2 4258.5 5793.4 5920.7 5923.3 5937.1 5939.2 5719.4 5719.9 5721.3 5724.5 5732.7 5721.7 5722.3 5736.4 5739.9 5743.0 5612.2 5616.1 5618.9 5619.6 5619.6 5625.4 5762.7 5766.2 5767.4 5768.9 5603.4 5607.9 5608.4 5611.5 5612.8 14:27:01 INFO - 2015-11-25 14:27:01,120 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,120 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12082.86 Median:23091.94 stddev:13933.15 (60.3%) stddev-sans-first:13945.87 14:27:01 INFO - 2015-11-25 14:27:01,121 DEBUG : BROWSER_OUTPUT: Values: 669.6 712.0 752.5 754.0 786.4 11458.4 11619.6 11652.2 11663.7 11669.1 10196.9 10658.9 11054.2 11308.7 11443.7 760.1 775.5 776.3 776.5 777.4 768.4 776.1 776.4 777.1 778.0 800.2 805.3 807.8 808.5 808.7 800.5 800.5 800.6 801.5 801.8 595.5 597.1 597.4 598.3 598.3 10289.9 10369.3 10384.5 10404.4 10457.1 9448.3 9682.5 9753.2 9825.2 10095.4 8829.2 10025.5 10057.8 10360.8 10406.6 3278.7 3286.2 3308.0 3311.4 3404.3 34305.7 34506.0 34738.5 35615.3 43190.8 8846.4 8979.4 9392.5 9494.4 9588.0 16229.8 16241.8 16271.3 16271.8 16277.4 6425.7 6479.6 6516.7 6522.4 6676.0 3587.6 3589.6 3610.7 3669.2 3718.7 2760.4 2789.5 2790.4 2792.3 2797.9 470.8 486.6 487.6 495.9 505.5 423.1 423.6 430.5 457.1 493.4 7280.8 7376.9 7604.1 7642.4 7645.8 505.3 517.8 527.5 546.0 555.5 3370.4 3433.8 3487.6 3616.7 3626.6 49007.0 52464.7 52605.7 52632.7 52792.7 44475.3 45657.0 45726.8 46141.8 46279.0 35872.3 39996.2 40065.4 40550.2 40855.4 7595.6 7675.5 7787.6 8112.1 8134.7 31947.8 32044.7 32568.7 32672.0 32806.3 39897.6 40759.4 41159.4 41210.2 41288.8 8770.7 9598.6 9712.8 9721.2 9725.8 10810.0 10864.0 10894.6 11002.8 11129.1 10071.0 10074.5 10078.2 10080.3 10449.2 10220.6 10494.7 10808.4 10866.1 10961.7 10428.2 10435.8 10506.2 10523.6 10523.9 8498.7 8554.6 8931.3 8964.3 9241.4 8053.7 8056.5 8146.8 8710.9 8992.1 14:27:01 INFO - 2015-11-25 14:27:01,121 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:27:01 INFO - 2015-11-25 14:27:01,121 DEBUG : BROWSER_OUTPUT: 14:27:01 INFO - 2015-11-25 14:27:01,877 INFO : Browser exited with error code: 0 14:27:01 INFO - 2015-11-25 14:27:01,901 INFO : Completed test dromaeo_css (00:18:36) 14:27:01 INFO - 2015-11-25 14:27:01,901 INFO : Starting test kraken 14:27:01 INFO - 2015-11-25 14:27:01,901 DEBUG : operating with platform_type : linux_ 14:27:01 INFO - 2015-11-25 14:27:01,901 INFO : Initialising browser for kraken test... 14:27:01 INFO - 2015-11-25 14:27:01,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEF48xU/profile http://localhost:44143/getInfo.html 14:27:06 INFO - 2015-11-25 14:27:06,096 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:27:06 INFO - 2015-11-25 14:27:06,096 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:27:06 INFO - 2015-11-25 14:27:06,096 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:27:06 INFO - 2015-11-25 14:27:06,097 DEBUG : BROWSER_OUTPUT: __metrics 14:27:06 INFO - 2015-11-25 14:27:06,258 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:27:07 INFO - 2015-11-25 14:27:07,528 INFO : Browser initialized. 14:27:07 INFO - 2015-11-25 14:27:07,528 INFO : Running cycle 1/1 for kraken test... 14:27:07 INFO - 2015-11-25 14:27:07,529 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEF48xU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:27:19 INFO - 2015-11-25 14:27:19,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 145600512 14:27:19 INFO - 2015-11-25 14:27:19,385 DEBUG : BROWSER_OUTPUT: 14:27:22 INFO - 2015-11-25 14:27:22,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44143/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:22 INFO - 2015-11-25 14:27:22,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 183738368 14:27:22 INFO - 2015-11-25 14:27:22,636 DEBUG : BROWSER_OUTPUT: 14:27:25 INFO - 2015-11-25 14:27:25,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44143/tests/kraken/driver.html?testName=audio-dft) 14:27:25 INFO - 2015-11-25 14:27:25,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 173084672 14:27:25 INFO - 2015-11-25 14:27:25,948 DEBUG : BROWSER_OUTPUT: 14:27:28 INFO - 2015-11-25 14:27:28,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44143/tests/kraken/driver.html?testName=audio-fft) 14:27:29 INFO - 2015-11-25 14:27:29,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 158818304 14:27:29 INFO - 2015-11-25 14:27:29,533 DEBUG : BROWSER_OUTPUT: 14:27:31 INFO - 2015-11-25 14:27:31,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44143/tests/kraken/driver.html?testName=audio-oscillator) 14:27:32 INFO - 2015-11-25 14:27:32,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 161349632 14:27:32 INFO - 2015-11-25 14:27:32,155 DEBUG : BROWSER_OUTPUT: 14:27:34 INFO - 2015-11-25 14:27:34,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:34 INFO - 2015-11-25 14:27:34,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 161624064 14:27:34 INFO - 2015-11-25 14:27:34,958 DEBUG : BROWSER_OUTPUT: 14:27:37 INFO - 2015-11-25 14:27:37,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44143/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:38 INFO - 2015-11-25 14:27:38,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 160698368 14:27:38 INFO - 2015-11-25 14:27:38,540 DEBUG : BROWSER_OUTPUT: 14:27:41 INFO - 2015-11-25 14:27:41,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44143/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:42 INFO - 2015-11-25 14:27:42,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 161787904 14:27:42 INFO - 2015-11-25 14:27:42,492 DEBUG : BROWSER_OUTPUT: 14:27:45 INFO - 2015-11-25 14:27:45,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44143/tests/kraken/driver.html?testName=json-parse-financial) 14:27:45 INFO - 2015-11-25 14:27:45,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 162205696 14:27:45 INFO - 2015-11-25 14:27:45,979 DEBUG : BROWSER_OUTPUT: 14:27:47 INFO - 2015-11-25 14:27:47,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:48 INFO - 2015-11-25 14:27:48,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 172974080 14:27:48 INFO - 2015-11-25 14:27:48,315 DEBUG : BROWSER_OUTPUT: 14:27:50 INFO - 2015-11-25 14:27:50,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:50 INFO - 2015-11-25 14:27:50,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 171663360 14:27:50 INFO - 2015-11-25 14:27:50,819 DEBUG : BROWSER_OUTPUT: 14:27:52 INFO - 2015-11-25 14:27:52,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:53 INFO - 2015-11-25 14:27:53,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 180350976 14:27:53 INFO - 2015-11-25 14:27:53,498 DEBUG : BROWSER_OUTPUT: 14:27:56 INFO - 2015-11-25 14:27:56,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:56 INFO - 2015-11-25 14:27:56,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 186978304 14:27:56 INFO - 2015-11-25 14:27:56,632 DEBUG : BROWSER_OUTPUT: 14:27:59 INFO - 2015-11-25 14:27:59,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:59 INFO - 2015-11-25 14:27:59,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 184422400 14:27:59 INFO - 2015-11-25 14:27:59,828 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44143/tests/kraken/driver.html?testName=ai-astar) 14:28:01 INFO - 2015-11-25 14:28:01,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 244359168 14:28:01 INFO - 2015-11-25 14:28:01,841 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;107;114;114;113;101;113;113;103 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;156;167;131;160;151;133;170;131 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;159;160;163;163;162;162 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;81;95;73;73;72;95;92;71 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;131;94;94;95;130;94;94;135 14:28:01 INFO - 2015-11-25 14:28:01,845 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;109;110;109;109;110 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;146;147;146;147;146;146 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;94;96;95;95 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;71;70;71;71;71;71;70 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;72;72;73;73;73;74;73;72;73 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;84;82;84;83;83;84;84;85 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;116;127;119;120;127;135;127;120;121 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;146;163;146;148;142;148;146;149;136 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;70;67;70;69;68;68;67;68 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1007 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490481844__endTimestamp 14:28:01 INFO - 2015-11-25 14:28:01,846 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:113.00 stddev:4.75 (4.2%) stddev-sans-first:5.02 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 107.0 114.0 114.0 113.0 101.0 113.0 113.0 103.0 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.50 stddev:15.76 (10.1%) stddev-sans-first:16.54 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 156.0 167.0 131.0 160.0 151.0 133.0 170.0 131.0 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,850 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 159.0 160.0 163.0 163.0 162.0 162.0 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:77.50 stddev:10.21 (13.2%) stddev-sans-first:10.43 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 81.0 95.0 73.0 73.0 72.0 95.0 92.0 71.0 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.00 stddev:18.26 (19.4%) stddev-sans-first:18.97 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 131.0 94.0 94.0 95.0 130.0 94.0 94.0 135.0 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:28:01 INFO - 2015-11-25 14:28:01,851 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.60 Median:71.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 71.0 70.0 71.0 71.0 71.0 71.0 70.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.67 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 73.0 73.0 73.0 74.0 73.0 72.0 73.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.87 (3.4%) stddev-sans-first:2.92 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 84.0 82.0 84.0 83.0 83.0 84.0 84.0 85.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:127.00 stddev:5.72 (4.5%) stddev-sans-first:5.88 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: Values: 128.0 116.0 127.0 119.0 120.0 127.0 135.0 127.0 120.0 121.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:148.00 stddev:6.78 (4.6%) stddev-sans-first:7.17 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 163.0 146.0 148.0 142.0 148.0 146.0 149.0 136.0 14:28:01 INFO - 2015-11-25 14:28:01,852 DEBUG : BROWSER_OUTPUT: 14:28:01 INFO - 2015-11-25 14:28:01,853 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 14:28:01 INFO - 2015-11-25 14:28:01,853 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 70.0 67.0 70.0 69.0 68.0 68.0 67.0 68.0 14:28:01 INFO - 2015-11-25 14:28:01,853 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:28:01 INFO - 2015-11-25 14:28:01,853 DEBUG : BROWSER_OUTPUT: 14:28:02 INFO - 2015-11-25 14:28:02,721 INFO : Browser exited with error code: 0 14:28:02 INFO - 2015-11-25 14:28:02,829 INFO : Completed test kraken (00:01:00) 14:28:02 INFO - 2015-11-25 14:28:02,829 INFO : Starting test v8_7 14:28:02 INFO - 2015-11-25 14:28:02,829 DEBUG : operating with platform_type : linux_ 14:28:02 INFO - 2015-11-25 14:28:02,829 INFO : Initialising browser for v8_7 test... 14:28:02 INFO - 2015-11-25 14:28:02,835 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxwaQF_/profile http://localhost:44143/getInfo.html 14:28:07 INFO - 2015-11-25 14:28:07,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:28:07 INFO - 2015-11-25 14:28:07,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:28:07 INFO - 2015-11-25 14:28:07,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:28:07 INFO - 2015-11-25 14:28:07,113 DEBUG : BROWSER_OUTPUT: __metrics 14:28:07 INFO - 2015-11-25 14:28:07,282 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:08 INFO - 2015-11-25 14:28:08,556 INFO : Browser initialized. 14:28:08 INFO - 2015-11-25 14:28:08,556 INFO : Running cycle 1/1 for v8_7 test... 14:28:08 INFO - 2015-11-25 14:28:08,557 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxwaQF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:28:20 INFO - 2015-11-25 14:28:20,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 147890176 14:28:20 INFO - 2015-11-25 14:28:20,379 DEBUG : BROWSER_OUTPUT: 14:28:41 INFO - 2015-11-25 14:28:41,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44143/tests/v8_7/run.html (next: http://localhost:44143/tests/v8_7/run.html) 14:28:42 INFO - 2015-11-25 14:28:42,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 439029760 14:28:42 INFO - 2015-11-25 14:28:42,104 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,105 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:28:42 INFO - 2015-11-25 14:28:42,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:28:42 INFO - 2015-11-25 14:28:42,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |0;Richards;166.00265604249668 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.4975755315181 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 14:28:42 INFO - 2015-11-25 14:28:42,106 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: |8;Splay;613.4969325153374 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: __startTimestamp1448490522104__endTimestamp 14:28:42 INFO - 2015-11-25 14:28:42,107 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,109 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:28:42 INFO - 2015-11-25 14:28:42,109 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:28:42 INFO - 2015-11-25 14:28:42,109 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,109 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,109 DEBUG : BROWSER_OUTPUT: Values: 166.0 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.50 Median:186.50 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: Values: 186.5 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: Values: 277.9 14:28:42 INFO - 2015-11-25 14:28:42,110 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: Values: 5196.9 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: Values: 1955.1 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,111 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: Values: 786.2 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: Values: 12047.6 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,112 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: Values: 25897.4 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.50 Median:613.50 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: Values: 613.5 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 14:28:42 INFO - 2015-11-25 14:28:42,113 DEBUG : BROWSER_OUTPUT: Values: 4854.4 14:28:42 INFO - 2015-11-25 14:28:42,114 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:28:42 INFO - 2015-11-25 14:28:42,114 DEBUG : BROWSER_OUTPUT: 14:28:43 INFO - 2015-11-25 14:28:43,025 INFO : Browser exited with error code: 0 14:28:43 INFO - 2015-11-25 14:28:43,042 INFO : Completed test v8_7 (00:00:40) 14:28:43 INFO - 2015-11-25 14:28:43,070 INFO : Completed test suite (00:20:18) 14:28:43 INFO - 2015-11-25 14:28:43,071 DEBUG : Working with test: dromaeo_css 14:28:43 INFO - 2015-11-25 14:28:43,071 DEBUG : Generating results file: dromaeo_css 14:28:43 INFO - 2015-11-25 14:28:43,072 DEBUG : Working with test: kraken 14:28:43 INFO - 2015-11-25 14:28:43,072 DEBUG : Generating results file: kraken 14:28:43 INFO - 2015-11-25 14:28:43,072 INFO : javascript benchmark 14:28:43 INFO - 2015-11-25 14:28:43,072 DEBUG : Working with test: v8_7 14:28:43 INFO - 2015-11-25 14:28:43,073 DEBUG : Generating results file: v8_7 14:28:43 INFO - 2015-11-25 14:28:43,073 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:43 INFO - 2015-11-25 14:28:43,133 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,144,35]] 14:28:43 INFO - 2015-11-25 14:28:43,133 DEBUG : process_Request line: dromaeo_css 6305.42 graph.html#tests=[[72,144,35]] 14:28:43 INFO - 2015-11-25 14:28:43,134 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:43 INFO - 2015-11-25 14:28:43,163 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,144,35]] 14:28:43 INFO - 2015-11-25 14:28:43,163 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:43 INFO - 2015-11-25 14:28:43,195 DEBUG : process_Request line: v8_7 19900.71 graph.html#tests=[[230,144,35]] 14:28:43 INFO - 2015-11-25 14:28:43,200 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.093307808806, 2711.308616302844, 2714.0772137473255, 2738.9999999999986, 2747.354371722645, 4490.348899409583, 4574.862754117374, 4627.282771170466, 4663.300504924259, 4664.277037059257, 4556.589906908378, 4557.065801510691, 4647.651426143045, 4650.465196502403, 4677.953220467794, 4269.274223382033, 4280.828766849322, 4281.207976524337, 4329.891752706176, 4338.370936214247, 4133.111381053073, 4400.669949753766, 4401.449818772653, 4446.533114023029, 4453.109378124388, 4250.532441431471, 4265.850695225652, 4289.656827453828, 4316.158349121923, 4351.6953813233085, 4304.246756817575, 4322.459692538433, 4326.8269269229195, 4327.459067616548, 4364.5635436456105, 4112.753234805891, 4223.831046758126, 4290.184864875695, 4308.82764689412, 4358.3244597087505, 4465.24090904547, 4566.520515345907, 4634.768261586907, 4656.254999200146, 4686.742229177394, 5077.720725360104, 5091.694498330075, 5097.974510127463, 5118.820841270538, 5144.356955380577, 4841.298011788306, 4957.7769000395065, 5105.770240339194, 5118.513741194581, 5138.58891288696, 4620.768961551943, 4672.112298663243, 4672.369230153954, 4682.0, 4742.004179122354, 5203.0, 5229.4770522948165, 5230.293910322134, 5233.973830130825, 5255.947440525546, 4701.412323459567, 4804.615630749532, 5016.197408414636, 5020.849374518771, 5072.137736584789, 4929.211326187793, 4994.0, 5069.771860266297, 5074.238864170404, 5093.1087059764395, 5046.6719663221775, 5058.165402708585, 5063.772130254148, 5064.848054558369, 5111.0, 4781.067691800135, 4921.0, 5002.174641184237, 5003.24951257307, 5013.24801279811, 4193.832246710097, 4210.0948296116485, 4241.300185469425, 4260.723053001607, 4280.293751531025, 3698.334299826003, 3707.14735610811, 3728.2729867675544, 3738.36447803874, 3766.077311058808, 4127.236461254677, 4410.889727756832, 4416.757078360657, 4423.60187583119, 4462.843800466968, 4999.275105109738, 5013.724245166551, 5020.196768517019, 5086.64393492452, 5144.61415393847, 4366.934495982563, 4372.956270437318, 4393.956060439355, 4397.934030989538, 4432.0, 4279.443672322641, 4563.201439748097, 4563.771811409416, 4567.200739870509, 4604.930926036112, 4658.906821863544, 4681.976590117096, 4696.365990591226, 4742.691725037862, 4791.401074865642, 5079.568236699922, 5154.304168937146, 5154.458781827854, 5172.689638621695, 5213.45258747826, 4581.266997280419, 4877.097736918681, 4897.289892965571, 4899.583535399531, 4946.8763280918265, 4869.31829543857, 4879.194932836042, 4909.214525676018, 4941.085899108676, 5005.524475174852, 5058.0, 5086.872828179177, 5088.6946783193125, 5089.465606111453, 5136.768845402041, 4646.465656449416, 4915.582175515121, 4915.877103072452, 4924.285978533021, 4967.751612419437, 4819.2530157825595, 4821.54195351441, 4842.830500932591, 4874.8537543873745, 4890.168671325954, 4840.273958906192, 4845.5881250094135, 4863.878403039952, 4867.172580661225, 4913.140200464976, 4713.3636959011465, 4974.801007959641, 4990.975045124751, 4991.9500804991485, 5034.395872495324, 4663.883402914954, 4714.646401519968, 4763.976180119077, 4827.131116399082, 4894.241392584155], "unit": "ms", "name": "dojo.html", "value": 4618.826081105449}, {"lowerIsBetter": false, "replicates": [553.5626854784717, 562.9240052592899, 574.1330590807879, 576.3861487515795, 583.7694110826222, 27227.319317017085, 27690.861545692267, 36172.81913590435, 36771.63228367716, 36799.63200367995, 40337.39493907594, 40811.79594102025, 40857.59142408575, 40914.7954260229, 40929.795351023204, 6909.689063992108, 7913.446058775902, 8086.110527841962, 8097.757067287961, 8099.797505062362, 6916.65416729164, 10296.639617613386, 10553.0, 10560.47197640115, 10572.418516981563, 10278.691639250797, 10368.222383321281, 10369.274150809446, 10381.273310868242, 10383.636572719955, 6980.162380514371, 7144.285571442866, 10076.445795481246, 10097.343672661253, 10180.847287290733, 10084.647037353658, 10218.029287217703, 10218.489075546267, 10221.233407494394, 10232.232582556338, 38438.423423648666, 38968.22063558713, 39038.60961390378, 39078.41382379267, 39087.41368879469, 2970.0941212930047, 2971.227480854972, 2974.628171478565, 2995.65549961755, 3563.002359339389, 28471.492134988348, 28858.567121493194, 28906.855465722747, 28984.565231521545, 29567.40865182684, 3430.4168291390524, 3492.0, 3503.1242189452637, 3561.626029266916, 3620.4026335654585, 224145.0, 224586.0, 225758.0, 226421.0, 226965.0, 51628.48371516312, 53220.0, 57329.713351432976, 58192.4180758187, 63517.0, 57426.71286643624, 57589.13616295759, 57666.711666442236, 57801.421985779605, 57811.0, 12894.0, 12997.935010325076, 12998.350082495837, 13009.739805203842, 13031.543895963596, 9959.80080398388, 10035.648752293635, 10036.598536058622, 10042.096211341015, 10054.547545360476, 19108.2356705733, 19313.4205973821, 19339.80660193408, 19384.515387115436, 19399.709004364944, 6898.448124150156, 7043.0983634419445, 7092.078029856086, 7116.395106416013, 7125.35871771543, 783.2715574515755, 881.1628952495155, 936.2182577547824, 943.4150826487485, 1014.5333146752429, 25963.610545841828, 26280.34299142537, 26838.0, 29054.273643158667, 29485.557716634266, 875.5622188905547, 914.71001005285, 931.5994122527243, 945.3382632157517, 1021.8927012663563, 13351.465941362238, 13413.329333533284, 13428.73907292673, 13536.593902182753, 13619.182849028892, 265197.0, 269150.0, 270891.0, 270947.0, 271615.0, 45354.0, 45573.7721311398, 45605.31592026122, 45626.31560526595, 45628.08743825105, 1206.4691535724253, 1208.305732230274, 1211.0674780419029, 1211.2913945342073, 1220.3105245536244, 25061.624075638516, 25489.36276593026, 25667.486650266517, 26203.475930481665, 26351.0, 40767.59232407638, 41037.38443923403, 41296.79351603223, 41303.38044929389, 41333.0, 247728.0, 250084.0, 251782.0, 251961.0, 252467.0, 23367.182148624717, 24321.39196520101, 25316.493670126863, 28270.43459130847, 29403.411931760817, 32462.0, 36549.26901462009, 37167.0, 37195.62804371922, 37577.4363384544, 31308.843455782575, 31429.68570314359, 32013.519797203528, 32457.675423245466, 32759.67240327566, 31909.840450797597, 32001.519977200827, 32228.35543289168, 32512.187195320304, 32737.672623274415, 31959.201019974687, 32116.839415802773, 32125.35749285048, 32346.191345216557, 32396.676033239364, 28081.43837123287, 29071.854640726662, 29187.124386268446, 29203.0, 29303.413931721672, 22691.546169076195, 22829.0, 23047.769522304563, 23052.0, 23132.190373336853], "unit": "ms", "name": "ext.html", "value": 17077.5444109062}, {"lowerIsBetter": false, "replicates": [330.0181958672948, 333.2934179539377, 336.84085015053506, 336.92924485857986, 341.11140479052085, 12269.447874845631, 12685.492580296777, 15045.322960466778, 15266.542003739878, 16044.759328610065, 13648.11287266327, 14137.646558836033, 14635.268236588181, 15233.390664373439, 15273.77089343658, 4877.292792545079, 4944.33251511045, 4961.603071754251, 4962.354893863792, 5055.620828437864, 3539.5929468111112, 3605.513255710485, 5686.232358631594, 5823.505002074808, 5828.591998560102, 5755.913661295084, 5761.222234998263, 5775.3358363788075, 5777.306723193223, 5806.854828629276, 5121.359830021247, 5262.789488420459, 5268.5521730652945, 5274.657147285433, 5275.0, 4882.658213925027, 5069.619778516626, 5072.873178170538, 5076.314697515825, 5090.440051594322, 12135.757284854253, 12300.0, 12329.5068197272, 12349.567765128177, 16538.0, 1725.7325114607256, 1764.250193667686, 1799.973000404995, 1856.303886042734, 1938.1375287996848, 9274.629014839398, 9346.859797103049, 11015.118790496741, 11729.06167506606, 13019.088663793538, 1727.8963262204181, 1729.2132079903613, 1736.748171515136, 1793.390247315919, 1793.8698619869529, 54521.72739136279, 55660.16509752317, 56312.71843640756, 56540.71729641366, 57806.42193578053, 9723.708288751348, 9796.040791841519, 9843.064908833649, 9847.901520984842, 9889.752756181153, 12398.876011239772, 12408.56570020045, 12411.131220814455, 12442.315672638091, 12461.626151215296, 6311.558190926591, 8019.077806052262, 8157.306628936488, 8174.100848906615, 8194.877076843852, 6510.609363438209, 6587.176602924635, 6654.600723956578, 6815.42068924147, 7156.749513767098, 7406.148292946273, 7434.442416818761, 7509.699612015567, 7516.060492438445, 7580.9620951894885, 2405.807535397164, 2927.5315949448413, 2966.3029188140767, 3013.032163319129, 3075.1082186165763, 796.0010187215124, 799.6761311668783, 857.7469646454311, 866.787637028932, 945.1304799584399, 15842.841571584137, 16117.113558754381, 16317.265723042492, 16446.259918303705, 16572.668546629, 814.7352110563971, 862.905080441151, 893.946363218209, 910.8679241510076, 959.194276807485, 8387.287080598218, 8937.240334571505, 8940.15068568485, 9129.543522823833, 9282.396644218104, 482635.0, 511596.0, 519393.0, 526814.0, 528690.0, 74653.62673186707, 75522.0, 75740.62129689427, 76590.0, 78241.60879195567, 1065.9606883288732, 1066.6906597086759, 1068.3056013591072, 1075.7848430313968, 1087.1683162380784, 14613.342399592257, 14713.92643036778, 14838.18389988561, 14851.0, 14908.403663853325, 33370.33259334848, 33868.153296167795, 34298.82850585731, 35053.0, 35196.47205291974, 42385.5761442394, 43273.78363108164, 43617.12765744731, 44339.55660443354, 45438.54561454343, 8928.776780580538, 8944.86582701247, 9071.59177837012, 9171.44971301724, 9200.907990920005, 10746.570137194738, 11279.830802538132, 15311.15788631636, 16684.165791710122, 16707.49877503677, 12948.15836970594, 13012.154209976321, 13333.0, 13333.799992999919, 13353.39909704085, 13118.737625247633, 13146.27695476758, 13238.139520931109, 13341.19952802835, 13353.53262635803, 13282.402291896695, 13408.731825363244, 13576.456941722221, 13858.16850988944, 14151.929240353733, 8964.86552701697, 9148.268138549034, 9179.678711245075, 9193.816123677356, 9280.628774849201, 14096.0, 14153.455551643698, 14456.710865782836, 14523.85476145225, 14637.707245855236], "unit": "ms", "name": "jquery.html", "value": 8565.86471668991}, {"lowerIsBetter": false, "replicates": [1366.5763613279878, 1590.3559058581272, 1637.6560922206336, 1653.5436997292295, 1662.2270644150467, 5718.485336319731, 6573.211214654242, 6848.691808868601, 6859.897101543468, 6874.140732408443, 6797.218319893202, 6888.75889343873, 6917.792466226008, 6927.4458043356535, 6949.89575156373, 1700.472853415439, 1724.4136993422235, 1728.3173146607082, 2028.2698228637641, 2055.434755442258, 2030.4416285521527, 2085.1242478159133, 2085.655866781979, 2086.968695469569, 2087.2485905074163, 1983.5735316906862, 2024.7266619006466, 2031.6546187148147, 2032.3191730770209, 2032.4207600833765, 2048.7541495020546, 2079.563291708743, 2106.347032419947, 2106.8841213733162, 2107.2308607358204, 2091.393495886191, 2117.1213946212456, 2118.4492032071616, 2120.8409369297365, 2121.1197353098446, 6877.312268773133, 6942.757003504853, 6947.652617369111, 6953.374196322356, 6956.930430695729, 4078.490188726409, 4181.644560212386, 4211.031462763582, 4213.810378532973, 4215.241256573816, 2664.706882242952, 2770.293575138347, 2784.3456787654886, 2811.9297017574518, 2820.2667306500252, 742.8922806193126, 883.1654086887894, 894.6555576103248, 904.9819003619957, 931.8136372725414, 9037.141471560257, 9182.08179182083, 9190.908090919072, 9219.723408297761, 9223.123803238748, 3986.661133803659, 4003.979980100081, 4038.1318016626565, 4078.021274894004, 4080.4491393661474, 8002.439829211899, 8018.318442932299, 8038.236367545074, 8056.879146812803, 8082.19178082187, 4099.651529620016, 4139.875803725893, 4143.627073563393, 4148.854790082393, 4152.045029643199, 3776.244751049801, 3778.3387907116694, 3778.848846046182, 3779.848806047727, 3781.5084039074745, 3393.8642454302044, 3400.6939375456327, 3426.3318652862454, 3432.639572844865, 3451.81015044175, 1083.5394957143183, 1084.4740300954031, 1087.6193332333619, 1090.0734375780523, 1096.8628921384827, 789.1201310538708, 800.703739616334, 801.0187520287601, 802.4703695560902, 906.795970906554, 6300.684965751694, 6349.142865713162, 6349.396807303298, 6353.36466353361, 6362.586431881913, 432.675493379965, 440.79723327269176, 444.6576136375038, 446.33050424363455, 448.83617479619704, 4947.356843610308, 4951.529604687549, 5011.847275126668, 5022.924656130161, 5023.623228257895, 7980.162082981204, 7994.360451163893, 8219.465734727224, 8285.461445006054, 8311.625976831057, 8191.918080819235, 8194.385421093442, 8197.426180167331, 8210.220029097227, 8222.136675648972, 6378.617282963037, 6417.679116044273, 6495.350464953562, 6496.480281577463, 6578.5395022347975, 6061.939380606137, 6131.294901086254, 6132.325444201045, 6136.662483563268, 6139.6009259398, 7123.536970096927, 7360.77917662471, 7377.225391333833, 7386.519876208029, 7414.369778568882, 7406.666699998621, 7576.128745194374, 7588.27911348421, 7600.923990760021, 7642.8089297768, 6025.939740602538, 6030.698465076816, 6063.302720187235, 6079.209702738615, 6080.787172448943, 6310.495160387066, 6322.209723784527, 6382.170317858649, 6424.486041116793, 6446.194225721785, 6084.482818960438, 6089.147519347206, 6162.0, 6180.196574445294, 6204.72078756448, 6048.274207095177, 6073.757049718139, 6074.544409169242, 6138.907916381168, 6194.132821405097, 5947.524198064058, 5987.072003839412, 6002.219711437485, 6059.303180134341, 6065.4541091302, 5661.320641523043, 5692.743826527733, 5707.600467967369, 5720.856978575569, 5722.7710891563875, 4924.532169443897, 5613.186088017296, 5663.207150998781, 5664.716764161858, 5692.914606280992], "unit": "ms", "name": "mootools.html", "value": 3865.8340109780056}, {"lowerIsBetter": false, "replicates": [315.43694505308025, 318.7402267152271, 320.5576304699515, 322.89505910579066, 324.68829923273654, 5268.710220937856, 5408.350997880255, 5443.1835224716315, 5474.069408200606, 5505.944940550593, 5237.685738855671, 5372.677639341642, 5394.676319420838, 5398.973005134969, 5409.323109835944, 4265.0, 4269.679774016946, 4271.359296105586, 4274.230638485072, 4283.32950149442, 4025.235205310996, 4088.4684990951137, 4097.13960068386, 4100.733452325604, 4264.594863487963, 4054.6350828425434, 4063.1061166543313, 4094.733842300241, 4166.916661666764, 4191.287481128215, 4198.538160802309, 4209.347551129596, 4216.97891510542, 4223.260929337384, 4224.831006759726, 3681.8402203305873, 3712.6844218241213, 3726.087108658396, 3734.514513113305, 3739.326921154191, 5059.620528460343, 5229.973850130763, 5230.712310822903, 5240.3973543042275, 5242.266082748418, 4877.268409738532, 4883.145449546315, 4883.829065982709, 4888.0957022950515, 4896.804127834882, 5708.115242137475, 5714.057180565202, 5714.7428365723645, 5723.942760572382, 5726.656400615976, 3839.462475253467, 3948.4669569608022, 4002.3396139636925, 4092.5498195198506, 4107.301758700998, 5968.253968253968, 5996.97001514994, 5998.940010599926, 6026.638401695912, 6041.72812223451, 4190.811413486401, 4192.182524407772, 4192.769397683096, 4202.810873510699, 4219.156168766259, 4273.423087883159, 4277.443932288783, 4277.828886844553, 4280.892977675583, 4284.935725964113, 4723.622110231242, 4842.15262329091, 4850.417949846041, 4861.659683822169, 4869.70781753096, 5715.085586306254, 5735.598508104393, 5739.081746920473, 5748.252727145445, 5750.971245143747, 1502.6318551954623, 1523.2764436892387, 1523.7790520374483, 1525.3136088760102, 1525.7406240939067, 1046.4767616191905, 1051.033049594375, 1052.3685788526823, 1053.599632139782, 1073.9194560408, 5012.198048312325, 5013.39839219296, 5017.197248440232, 5017.347744793154, 5020.447750747415, 5944.346121926585, 5944.464998150187, 5945.0, 5948.226730525004, 5951.196588460589, 5012.548870601663, 5014.749262536859, 5015.749212539358, 5016.745813546613, 5017.046761115449, 3141.748660107186, 3183.6657150999276, 3218.7103160715646, 3224.596925384327, 3226.1934516370907, 5596.076647353222, 5613.8596535086135, 5615.466530679579, 5615.522680572116, 5624.409437009055, 6093.177421048191, 6093.268807743099, 6095.299040610298, 6096.177016102769, 6097.7865774697675, 5481.75332110048, 5587.888242235133, 5607.43925607436, 5611.102223644279, 5617.157426386075, 5957.076653118774, 5963.821085367446, 5963.940360596339, 5969.04495280753, 5978.491828194478, 5637.1262454318, 5770.567207459373, 5772.884542309214, 5830.854228644318, 5837.766489340379, 5487.396386397413, 5587.580931430078, 5646.943530564806, 5649.265595472562, 5679.574031947538, 4207.621314081747, 4249.97875010623, 4254.787260637017, 4258.169656916872, 4258.467691538558, 5793.420657934173, 5920.674362909909, 5923.348431672599, 5937.109433584997, 5939.16851640762, 5719.428057194247, 5719.885602287848, 5721.342045664635, 5724.513416359489, 5732.684702341411, 5721.7425215866215, 5722.341930678025, 5736.42635736423, 5739.942600573941, 5743.023685973478, 5612.186232996274, 5616.073347897551, 5618.915716264341, 5619.550435965031, 5619.578531610227, 5625.437456254342, 5762.683052432157, 5766.192733017465, 5767.394423585463, 5768.855778605568, 5603.411641777555, 5607.943920560742, 5608.439156084359, 5611.466910643482, 5612.831615051555], "unit": "ms", "name": "prototype.html", "value": 4323.238171754333}, {"lowerIsBetter": false, "replicates": [669.5848573884192, 711.9893201601977, 752.4544705088811, 753.9811504712378, 786.3944762532848, 11458.369789661565, 11619.593314234004, 11652.242604230729, 11663.650090497298, 11669.066474682026, 10196.949015254932, 10658.946705266462, 11054.226204165712, 11308.717282067952, 11443.656690299284, 760.0575286644548, 775.5269285735696, 776.2664282253273, 776.4952780692538, 777.3703300326754, 768.3852917665873, 776.1036003416064, 776.409928454376, 777.0946846923327, 777.9805504862395, 800.1998001998002, 805.3355981315439, 807.7940125268049, 808.4664121679692, 808.6765293882436, 800.4756884240802, 800.4876878797545, 800.5516910530064, 801.4830434369799, 801.7795106345743, 595.5176307191145, 597.1162679234714, 597.3727586034646, 598.308953159102, 598.3418239936079, 10289.948550257275, 10369.325993810378, 10384.532696028697, 10404.427756473391, 10457.058864702138, 9448.291378146598, 9682.515874206332, 9753.21974242059, 9825.164860986824, 10095.394276343442, 8829.205371516595, 10025.498725063791, 10057.798844023078, 10360.844587331196, 10406.583736650526, 3278.7377009839156, 3286.1948822538393, 3307.991062725868, 3311.420501412267, 3404.3361544498835, 34305.6569434305, 34506.0, 34738.478922816175, 35615.28769424597, 43190.78404607988, 8846.380753347205, 8979.371443998858, 9392.483413412328, 9494.430334179971, 9587.99416382969, 16229.756553651705, 16241.83758162427, 16271.349146034263, 16271.83728162727, 16277.430289939795, 6425.678716064178, 6479.611223326616, 6516.674166291761, 6522.412982831568, 6675.966620166868, 3587.6232995535615, 3589.6410358963894, 3610.693091087287, 3669.1560940983723, 3718.7396882217986, 2760.4065125997604, 2789.539725945237, 2790.4140130572805, 2792.2600510864636, 2797.9020734274204, 470.83991442909576, 486.576678289883, 487.61478432039, 495.87850976510987, 505.54753495621213, 423.1135770560671, 423.6039303251408, 430.5350221760491, 457.11548154321497, 493.40298239130334, 7280.8179795504475, 7376.926230737731, 7604.087509498895, 7642.426817988673, 7645.770626881203, 505.2623170171591, 517.8291163915899, 527.4777969809937, 546.0035435330537, 555.4639772619441, 3370.427027405347, 3433.776804507699, 3487.5640544931885, 3616.728745344057, 3626.637336266405, 49007.0, 52464.737676312136, 52605.7369713149, 52632.73683631558, 52792.73603632034, 44475.332870006976, 45657.0, 45726.77136614296, 46141.769291154, 46279.0, 35872.28255434876, 39996.20007599832, 40065.39901901474, 40550.18899621991, 40855.38716919249, 7595.5822429766895, 7675.53946763196, 7787.649555770117, 8112.10766815638, 8134.674613015413, 31947.840260798548, 32044.67955320417, 32568.674313256564, 32672.0, 32806.34387312193, 39897.60102399055, 40759.388609170295, 41159.38260926028, 41210.1757964845, 41288.793556033226, 8770.693025744069, 9598.568064437257, 9712.75718107053, 9721.222302215947, 9725.756856078655, 10810.0, 10864.0, 10894.564217431214, 11002.779944401227, 11129.10967122612, 10071.0, 10074.546645400827, 10078.244131690299, 10080.294379393665, 10449.21630877672, 10220.642277520252, 10494.68515944523, 10808.405537695502, 10866.07638350749, 10961.725956851142, 10428.165746740395, 10435.843462348223, 10506.159507239556, 10523.631672891719, 10523.894761052597, 8498.70254541088, 8554.615042322986, 8931.330150238888, 8964.282857371525, 9241.445513268956, 8053.718119865776, 8056.476329038828, 8146.75559733209, 8710.91289087101, 8992.100789920956], "unit": "ms", "name": "yui.html", "value": 5564.884190847495}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 114.0, 114.0, 113.0, 101.0, 113.0, 113.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 156.0, 167.0, 131.0, 160.0, 151.0, 133.0, 170.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 160.0, 163.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 81.0, 95.0, 73.0, 73.0, 72.0, 95.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 131.0, 94.0, 94.0, 95.0, 130.0, 94.0, 94.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 73.0, 73.0, 73.0, 74.0, 73.0, 72.0, 73.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 72.7}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 84.0, 82.0, 84.0, 83.0, 83.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [128.0, 116.0, 127.0, 119.0, 120.0, 127.0, 135.0, 127.0, 120.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 163.0, 146.0, 148.0, 142.0, 148.0, 146.0, 149.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 67.0, 70.0, 69.0, 68.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [186.4975755315181], "unit": "score", "name": "DeltaBlue", "value": 354.524716}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [613.4969325153374], "unit": "score", "name": "Splay", "value": 132.83032999999998}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7"}]} 14:28:43 INFO - RETURN: dromaeo_css: 6305.42 14:28:43 INFO - RETURN: kraken: 1523.10 14:28:43 INFO - RETURN: v8_7: 19900.71 14:28:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,144,35]]", "result": "19900.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,144,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,144,35]]", "result": "6305.42"}}} 14:28:43 INFO - Return code: 0 14:28:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:28:43 INFO - # TBPL SUCCESS # 14:28:43 INFO - Running post-action listener: _resource_record_post_action 14:28:43 INFO - Running post-run listener: _resource_record_post_run 14:28:44 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552968192; Read time: 8; Write time: 594188 14:28:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231682048; Read time: 0; Write time: 305536 14:28:44 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 321286144; Read time: 0; Write time: 288652 14:28:44 INFO - Running post-run listener: _upload_blobber_files 14:28:44 INFO - Blob upload gear active. 14:28:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:28:44 INFO - Copying logs to upload dir... 14:28:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.734643 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 14:28:44.270905) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:28:44.275175) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009915 build_url: 'https://queue.taskcluster.net/v1/task/SP0zYpyURtKv6Sl-tZjUcw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 14:28:44.332528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:28:44.333242) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1448488885.536977-1495053301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 14:28:44.385695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 14:28:44.386261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 14:28:44.386918) ========= ========= Total master_lag: 0.25 =========