builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1477969500.74 results: success (0) buildid: 20161031183902 builduid: e1aba3addb834af68cb55d7f0f3f494b revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.739315) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.740368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.740923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.752733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.753049) ========= 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=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 20:05:00-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-10-31 20:05:01 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.857456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.857791) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014053 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.907680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:00.908048) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --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=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 20:05:01,128 truncating revision to first 12 chars 2016-10-31 20:05:01,128 Setting DEBUG logging. 2016-10-31 20:05:01,128 attempt 1/10 2016-10-31 20:05:01,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21153294d3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 20:05:01,565 unpacking tar archive at: mozilla-central-21153294d3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:01.714846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:01.715469) ========= script_repo_revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:01.716163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:01.716664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:05:01.729345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-31 20:05:01.729956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:02 INFO - MultiFileLogger online at 20161031 20:05:02 in /builds/slave/test 20:05:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:05:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:02 INFO - {'append_to_log': False, 20:05:02 INFO - 'base_work_dir': '/builds/slave/test', 20:05:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:05:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:02 INFO - 'branch': 'Firefox-Non-PGO', 20:05:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:02 INFO - 'config_files': ('talos/linux_config.py',), 20:05:02 INFO - 'default_actions': ('clobber', 20:05:02 INFO - 'read-buildbot-config', 20:05:02 INFO - 'download-and-extract', 20:05:02 INFO - 'populate-webroot', 20:05:02 INFO - 'create-virtualenv', 20:05:02 INFO - 'install', 20:05:02 INFO - 'run-tests'), 20:05:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:02 INFO - 'download_minidump_stackwalk': True, 20:05:02 INFO - 'download_symbols': 'ondemand', 20:05:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:02 INFO - 'installer_path': 'installer.exe', 20:05:02 INFO - 'log_level': 'info', 20:05:02 INFO - 'log_name': 'talos', 20:05:02 INFO - 'log_to_console': True, 20:05:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:02 INFO - 'opt_config_files': (), 20:05:02 INFO - 'pip_index': False, 20:05:02 INFO - 'sps_profile': False, 20:05:02 INFO - 'sps_profile_interval': 0, 20:05:02 INFO - 'suite': 'dromaeojs', 20:05:02 INFO - 'system_bits': '32', 20:05:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:02 INFO - 'title': 'talos-linux64-ix-054', 20:05:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:02 INFO - 'use_talos_json': True, 20:05:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:02 INFO - 'work_dir': 'build'} 20:05:02 INFO - [mozharness: 2016-11-01 03:05:02.045898Z] Running clobber step. 20:05:02 INFO - Running pre-action listener: _resource_record_pre_action 20:05:02 INFO - Running main action method: clobber 20:05:02 INFO - rmtree: /builds/slave/test/build 20:05:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:02 INFO - Running post-action listener: _resource_record_post_action 20:05:02 INFO - [mozharness: 2016-11-01 03:05:02.504321Z] Finished clobber step (success) 20:05:02 INFO - [mozharness: 2016-11-01 03:05:02.504422Z] Running read-buildbot-config step. 20:05:02 INFO - Running pre-action listener: _resource_record_pre_action 20:05:02 INFO - Running main action method: read_buildbot_config 20:05:02 INFO - Using buildbot properties: 20:05:02 INFO - { 20:05:02 INFO - "project": "", 20:05:02 INFO - "product": "firefox", 20:05:02 INFO - "script_repo_revision": "production", 20:05:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:05:02 INFO - "repository": "", 20:05:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:05:02 INFO - "buildid": "20161031183902", 20:05:02 INFO - "pgo_build": "False", 20:05:02 INFO - "basedir": "/builds/slave/test", 20:05:02 INFO - "buildnumber": 278, 20:05:02 INFO - "slavename": "talos-linux64-ix-054", 20:05:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:02 INFO - "platform": "ubuntu64_hw", 20:05:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:05:02 INFO - "branch": "mozilla-central", 20:05:02 INFO - "repo_path": "mozilla-central", 20:05:02 INFO - "revision": "21153294d3a0bf7ce8e5e6bb1a0e684745b88fda", 20:05:02 INFO - "stage_platform": "linux64", 20:05:02 INFO - "builduid": "e1aba3addb834af68cb55d7f0f3f494b", 20:05:02 INFO - "slavebuilddir": "test" 20:05:02 INFO - } 20:05:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:05:02 INFO - Running post-action listener: _resource_record_post_action 20:05:02 INFO - [mozharness: 2016-11-01 03:05:02.506858Z] Finished read-buildbot-config step (success) 20:05:02 INFO - [mozharness: 2016-11-01 03:05:02.506947Z] Running download-and-extract step. 20:05:02 INFO - Running pre-action listener: _resource_record_pre_action 20:05:02 INFO - Running main action method: download_and_extract 20:05:02 INFO - mkdir: /builds/slave/test/build/tests 20:05:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:02 INFO - trying https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:05:03 INFO - Downloaded 1361 bytes. 20:05:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:05:03 INFO - Using the following test package requirements: 20:05:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'jsshell-linux-x86_64.zip'], 20:05:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:05:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:03 INFO - Fetch https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:05:03 INFO - Http code: 200 20:05:03 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 20:05:03 INFO - x-amz-cf-id: 0kt_h61zEGDTYpPqdOvovONo5B6d3bpSi7VSKNQ_l2NlZVId5ptNyQ== 20:05:03 INFO - x-amz-version-id: hVNU.7yfRvgRhuKAcQXIyWaz.VJXlmf2 20:05:03 INFO - Expected file size: 20452283 20:05:03 INFO - Obtained file size: 20452283 20:05:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:05:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:05:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:05:08 INFO - Http code: 200 20:05:08 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 20:05:08 INFO - x-amz-cf-id: ujzigyeOm72Fu4TIBLrOTL1aky_8AP_jk8Q7XkA8FV5vo0JQfuI4ow== 20:05:08 INFO - x-amz-version-id: hVNU.7yfRvgRhuKAcQXIyWaz.VJXlmf2 20:05:08 INFO - Expected file size: 20452283 20:05:08 INFO - Obtained file size: 20452283 20:05:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:05:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:05:13 INFO - Http code: 200 20:05:13 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 20:05:13 INFO - x-amz-cf-id: ww8lyq5mX-339sLxjMwGSebdT6ISyXxf7eGVh9CNxkAZZSyRQSEHJQ== 20:05:13 INFO - x-amz-version-id: UXvXtFItzWOI3IbICcVc5Z_QG_AFwMC8 20:05:14 INFO - Expected file size: 14409038 20:05:14 INFO - Obtained file size: 14409038 20:05:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:14 INFO - trying https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:05:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:05:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:05:15 INFO - Downloaded 55806044 bytes. 20:05:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:05:15 INFO - mkdir: /builds/slave/test/properties 20:05:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:15 INFO - Contents: 20:05:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:05:16 INFO - Running post-action listener: _resource_record_post_action 20:05:16 INFO - Running post-action listener: set_extra_try_arguments 20:05:16 INFO - [mozharness: 2016-11-01 03:05:16.066350Z] Finished download-and-extract step (success) 20:05:16 INFO - [mozharness: 2016-11-01 03:05:16.066578Z] Running populate-webroot step. 20:05:16 INFO - Running pre-action listener: _resource_record_pre_action 20:05:16 INFO - Running main action method: populate_webroot 20:05:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:16 INFO - '--tppagecycles', 20:05:16 INFO - '7'], 20:05:16 INFO - 'tests': ['tsvgm']}}, 20:05:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['damp', 'tps']}, 20:05:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'tests': ['damp', 'tps']}, 20:05:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['dromaeo_dom']}, 20:05:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['basic_compositor_video']}, 20:05:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['a11yr', 20:05:16 INFO - 'ts_paint', 20:05:16 INFO - 'tpaint', 20:05:16 INFO - 'sessionrestore', 20:05:16 INFO - 'sessionrestore_no_auto_restore', 20:05:16 INFO - 'tabpaint']}, 20:05:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['tsvgx', 20:05:16 INFO - 'tsvgr_opacity', 20:05:16 INFO - 'tart', 20:05:16 INFO - 'tscrollx', 20:05:16 INFO - 'cart']}, 20:05:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:16 INFO - 'tsvgr_opacity', 20:05:16 INFO - 'tart', 20:05:16 INFO - 'tscrollx', 20:05:16 INFO - 'cart']}, 20:05:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'talos_options': ['--disable-e10s'], 20:05:16 INFO - 'tests': ['tp5o']}, 20:05:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'tests': ['tp5o']}, 20:05:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'talos_options': ['--disable-e10s', 20:05:16 INFO - '--xperf_path', 20:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:16 INFO - 'tests': ['tp5n']}, 20:05:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:16 INFO - 'talos_options': ['--xperf_path', 20:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:16 INFO - 'tests': ['tp5n']}}, 20:05:16 INFO - 'talos.zip': {'path': '', 20:05:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:16 INFO - Running post-action listener: _resource_record_post_action 20:05:16 INFO - [mozharness: 2016-11-01 03:05:16.089094Z] Finished populate-webroot step (success) 20:05:16 INFO - [mozharness: 2016-11-01 03:05:16.089180Z] Running create-virtualenv step. 20:05:16 INFO - Running pre-action listener: _resource_record_pre_action 20:05:16 INFO - Running main action method: create_virtualenv 20:05:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:16 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 20:05:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:16 INFO - Using real prefix '/usr' 20:05:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:18 INFO - Installing pip.................done. 20:05:18 INFO - Return code: 0 20:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:05:18 INFO - Reading from file tmpfile_stdout 20:05:18 INFO - Output received: 20:05:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:05:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:05:18 INFO - Using env: {'DISPLAY': ':0', 20:05:18 INFO - 'HOME': '/home/cltbld', 20:05:18 INFO - 'LANG': 'en_US.UTF-8', 20:05:18 INFO - 'LANGUAGE': 'en_US:en', 20:05:18 INFO - 'LOGNAME': 'cltbld', 20:05:18 INFO - 'MAIL': '/var/mail/cltbld', 20:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:18 INFO - 'MOZ_NO_REMOTE': '1', 20:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:18 INFO - 'NO_EM_RESTART': '1', 20:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:18 INFO - 'PWD': '/builds/slave/test', 20:05:18 INFO - 'SHELL': '/bin/bash', 20:05:18 INFO - 'SHLVL': '1', 20:05:18 INFO - 'TERM': 'linux', 20:05:18 INFO - 'TMOUT': '86400', 20:05:18 INFO - 'USER': 'cltbld', 20:05:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:18 INFO - '_': '/tools/buildbot/bin/python'} 20:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:19 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 20:05:19 INFO - Cleaning up... 20:05:19 INFO - Return code: 0 20:05:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:05:19 INFO - Using env: {'DISPLAY': ':0', 20:05:19 INFO - 'HOME': '/home/cltbld', 20:05:19 INFO - 'LANG': 'en_US.UTF-8', 20:05:19 INFO - 'LANGUAGE': 'en_US:en', 20:05:19 INFO - 'LOGNAME': 'cltbld', 20:05:19 INFO - 'MAIL': '/var/mail/cltbld', 20:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:19 INFO - 'MOZ_NO_REMOTE': '1', 20:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:19 INFO - 'NO_EM_RESTART': '1', 20:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:19 INFO - 'PWD': '/builds/slave/test', 20:05:19 INFO - 'SHELL': '/bin/bash', 20:05:19 INFO - 'SHLVL': '1', 20:05:19 INFO - 'TERM': 'linux', 20:05:19 INFO - 'TMOUT': '86400', 20:05:19 INFO - 'USER': 'cltbld', 20:05:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:19 INFO - '_': '/tools/buildbot/bin/python'} 20:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:19 INFO - Downloading/unpacking psutil>=3.1.1 20:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:21 INFO - Installing collected packages: psutil 20:05:21 INFO - Running setup.py install for psutil 20:05:21 INFO - building 'psutil._psutil_linux' extension 20:05:21 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 20:05:21 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 20:05:21 INFO - building 'psutil._psutil_posix' extension 20:05:21 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 20:05:21 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 20:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:22 INFO - Successfully installed psutil 20:05:22 INFO - Cleaning up... 20:05:22 INFO - Return code: 0 20:05:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:05:22 INFO - Using env: {'DISPLAY': ':0', 20:05:22 INFO - 'HOME': '/home/cltbld', 20:05:22 INFO - 'LANG': 'en_US.UTF-8', 20:05:22 INFO - 'LANGUAGE': 'en_US:en', 20:05:22 INFO - 'LOGNAME': 'cltbld', 20:05:22 INFO - 'MAIL': '/var/mail/cltbld', 20:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:22 INFO - 'MOZ_NO_REMOTE': '1', 20:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:22 INFO - 'NO_EM_RESTART': '1', 20:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:22 INFO - 'PWD': '/builds/slave/test', 20:05:22 INFO - 'SHELL': '/bin/bash', 20:05:22 INFO - 'SHLVL': '1', 20:05:22 INFO - 'TERM': 'linux', 20:05:22 INFO - 'TMOUT': '86400', 20:05:22 INFO - 'USER': 'cltbld', 20:05:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:22 INFO - '_': '/tools/buildbot/bin/python'} 20:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:22 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 20:05:22 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 20:05:22 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 20:05:22 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 20:05:22 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 20:05:22 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 20:05:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:24 INFO - Installing collected packages: mozsystemmonitor 20:05:24 INFO - Running setup.py install for mozsystemmonitor 20:05:24 INFO - Successfully installed mozsystemmonitor 20:05:24 INFO - Cleaning up... 20:05:24 INFO - Return code: 0 20:05:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:05:24 INFO - Using env: {'DISPLAY': ':0', 20:05:24 INFO - 'HOME': '/home/cltbld', 20:05:24 INFO - 'LANG': 'en_US.UTF-8', 20:05:24 INFO - 'LANGUAGE': 'en_US:en', 20:05:24 INFO - 'LOGNAME': 'cltbld', 20:05:24 INFO - 'MAIL': '/var/mail/cltbld', 20:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:24 INFO - 'MOZ_NO_REMOTE': '1', 20:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:24 INFO - 'NO_EM_RESTART': '1', 20:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:24 INFO - 'PWD': '/builds/slave/test', 20:05:24 INFO - 'SHELL': '/bin/bash', 20:05:24 INFO - 'SHLVL': '1', 20:05:24 INFO - 'TERM': 'linux', 20:05:24 INFO - 'TMOUT': '86400', 20:05:24 INFO - 'USER': 'cltbld', 20:05:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:24 INFO - '_': '/tools/buildbot/bin/python'} 20:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:05:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:05:26 INFO - warning: no files found matching '*.txt' 20:05:26 INFO - no previously-included directories found matching 'build' 20:05:26 INFO - no previously-included directories found matching 'dist' 20:05:26 INFO - no previously-included directories found matching '.git*' 20:05:26 INFO - Installing collected packages: jsonschema, functools32 20:05:26 INFO - Running setup.py install for functools32 20:05:27 INFO - warning: no files found matching '*.txt' 20:05:27 INFO - no previously-included directories found matching 'build' 20:05:27 INFO - no previously-included directories found matching 'dist' 20:05:27 INFO - no previously-included directories found matching '.git*' 20:05:27 INFO - Successfully installed jsonschema functools32 20:05:27 INFO - Cleaning up... 20:05:27 INFO - Return code: 0 20:05:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:05:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:05:27 INFO - Using env: {'DISPLAY': ':0', 20:05:27 INFO - 'HOME': '/home/cltbld', 20:05:27 INFO - 'LANG': 'en_US.UTF-8', 20:05:27 INFO - 'LANGUAGE': 'en_US:en', 20:05:27 INFO - 'LOGNAME': 'cltbld', 20:05:27 INFO - 'MAIL': '/var/mail/cltbld', 20:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:27 INFO - 'MOZ_NO_REMOTE': '1', 20:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:27 INFO - 'NO_EM_RESTART': '1', 20:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:27 INFO - 'PWD': '/builds/slave/test', 20:05:27 INFO - 'SHELL': '/bin/bash', 20:05:27 INFO - 'SHLVL': '1', 20:05:27 INFO - 'TERM': 'linux', 20:05:27 INFO - 'TMOUT': '86400', 20:05:27 INFO - 'USER': 'cltbld', 20:05:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:27 INFO - '_': '/tools/buildbot/bin/python'} 20:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:05:27 INFO - Cleaning up... 20:05:27 INFO - Return code: 0 20:05:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:05:27 INFO - Using env: {'DISPLAY': ':0', 20:05:27 INFO - 'HOME': '/home/cltbld', 20:05:27 INFO - 'LANG': 'en_US.UTF-8', 20:05:27 INFO - 'LANGUAGE': 'en_US:en', 20:05:27 INFO - 'LOGNAME': 'cltbld', 20:05:27 INFO - 'MAIL': '/var/mail/cltbld', 20:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:27 INFO - 'MOZ_NO_REMOTE': '1', 20:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:27 INFO - 'NO_EM_RESTART': '1', 20:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:27 INFO - 'PWD': '/builds/slave/test', 20:05:27 INFO - 'SHELL': '/bin/bash', 20:05:27 INFO - 'SHLVL': '1', 20:05:27 INFO - 'TERM': 'linux', 20:05:27 INFO - 'TMOUT': '86400', 20:05:27 INFO - 'USER': 'cltbld', 20:05:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:27 INFO - '_': '/tools/buildbot/bin/python'} 20:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:05:27 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 20:05:27 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 20:05:27 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 20:05:27 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 20:05:27 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 20:05:27 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 20:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:30 INFO - Downloading docopt-0.6.1.tar.gz 20:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:05:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:05:30 INFO - Running setup.py install for blobuploader 20:05:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:05:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:05:30 INFO - Running setup.py install for requests 20:05:30 INFO - Running setup.py install for docopt 20:05:30 INFO - Successfully installed blobuploader requests docopt 20:05:30 INFO - Cleaning up... 20:05:30 INFO - Return code: 0 20:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:05:30 INFO - Using env: {'DISPLAY': ':0', 20:05:30 INFO - 'HOME': '/home/cltbld', 20:05:30 INFO - 'LANG': 'en_US.UTF-8', 20:05:30 INFO - 'LANGUAGE': 'en_US:en', 20:05:30 INFO - 'LOGNAME': 'cltbld', 20:05:30 INFO - 'MAIL': '/var/mail/cltbld', 20:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:30 INFO - 'MOZ_NO_REMOTE': '1', 20:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:30 INFO - 'NO_EM_RESTART': '1', 20:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:30 INFO - 'PWD': '/builds/slave/test', 20:05:30 INFO - 'SHELL': '/bin/bash', 20:05:30 INFO - 'SHLVL': '1', 20:05:30 INFO - 'TERM': 'linux', 20:05:30 INFO - 'TMOUT': '86400', 20:05:30 INFO - 'USER': 'cltbld', 20:05:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:30 INFO - '_': '/tools/buildbot/bin/python'} 20:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:31 INFO - Running setup.py (path:/tmp/pip-xZaDGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:31 INFO - Running setup.py (path:/tmp/pip-99Aq0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:31 INFO - Running setup.py (path:/tmp/pip-siUMEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:31 INFO - Running setup.py (path:/tmp/pip-h6N6x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:31 INFO - Running setup.py (path:/tmp/pip-yOq0VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:31 INFO - Running setup.py (path:/tmp/pip-SlHGY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:31 INFO - Running setup.py (path:/tmp/pip-0PL7K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:31 INFO - Running setup.py (path:/tmp/pip-PtbCLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:31 INFO - Running setup.py (path:/tmp/pip-XB5Awf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:31 INFO - Running setup.py (path:/tmp/pip-CImpQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:31 INFO - Running setup.py (path:/tmp/pip-7rj_sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:31 INFO - Running setup.py (path:/tmp/pip-DR6GmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:31 INFO - Running setup.py (path:/tmp/pip-4moDDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:32 INFO - Running setup.py (path:/tmp/pip-HUzpHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:32 INFO - Running setup.py (path:/tmp/pip-CQUEPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:32 INFO - Running setup.py (path:/tmp/pip-QSflgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:32 INFO - Running setup.py (path:/tmp/pip-f3GpvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:05:32 INFO - Running setup.py install for manifestparser 20:05:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:05:32 INFO - Running setup.py install for mozcrash 20:05:32 INFO - Running setup.py install for mozdebug 20:05:32 INFO - Running setup.py install for mozdevice 20:05:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:05:32 INFO - Running setup.py install for mozfile 20:05:32 INFO - Running setup.py install for mozhttpd 20:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:05:32 INFO - Running setup.py install for mozinfo 20:05:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for mozInstall 20:05:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for mozleak 20:05:33 INFO - Running setup.py install for mozlog 20:05:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for moznetwork 20:05:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for mozprocess 20:05:33 INFO - Running setup.py install for mozprofile 20:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for mozrunner 20:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:05:33 INFO - Running setup.py install for mozscreenshot 20:05:33 INFO - Running setup.py install for moztest 20:05:34 INFO - Running setup.py install for mozversion 20:05:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:05:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:05:34 INFO - Cleaning up... 20:05:34 INFO - Return code: 0 20:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:05:34 INFO - Using env: {'DISPLAY': ':0', 20:05:34 INFO - 'HOME': '/home/cltbld', 20:05:34 INFO - 'LANG': 'en_US.UTF-8', 20:05:34 INFO - 'LANGUAGE': 'en_US:en', 20:05:34 INFO - 'LOGNAME': 'cltbld', 20:05:34 INFO - 'MAIL': '/var/mail/cltbld', 20:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:34 INFO - 'MOZ_NO_REMOTE': '1', 20:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:34 INFO - 'NO_EM_RESTART': '1', 20:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:34 INFO - 'PWD': '/builds/slave/test', 20:05:34 INFO - 'SHELL': '/bin/bash', 20:05:34 INFO - 'SHLVL': '1', 20:05:34 INFO - 'TERM': 'linux', 20:05:34 INFO - 'TMOUT': '86400', 20:05:34 INFO - 'USER': 'cltbld', 20:05:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:34 INFO - '_': '/tools/buildbot/bin/python'} 20:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:34 INFO - Running setup.py (path:/tmp/pip-Q2rhBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:34 INFO - Running setup.py (path:/tmp/pip-E0IjTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:34 INFO - Running setup.py (path:/tmp/pip-qzBRBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:34 INFO - Running setup.py (path:/tmp/pip-ztpC1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:34 INFO - Running setup.py (path:/tmp/pip-BwI1XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:34 INFO - Running setup.py (path:/tmp/pip-EOquMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:34 INFO - Running setup.py (path:/tmp/pip-25vGb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:34 INFO - Running setup.py (path:/tmp/pip-ovwtGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:34 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)) 20:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:34 INFO - Running setup.py (path:/tmp/pip-rITBdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:35 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:35 INFO - Running setup.py (path:/tmp/pip-FBNhjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:35 INFO - Running setup.py (path:/tmp/pip-AqsblE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:35 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:35 INFO - Running setup.py (path:/tmp/pip-gA8o9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:35 INFO - Running setup.py (path:/tmp/pip-2IKwSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:35 INFO - Running setup.py (path:/tmp/pip-ItrFi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:35 INFO - Running setup.py (path:/tmp/pip-6x16fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:35 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:35 INFO - Running setup.py (path:/tmp/pip-bbUqjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:35 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)) 20:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:35 INFO - Running setup.py (path:/tmp/pip-ci1NYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:35 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)) 20:05:35 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:05:35 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:05:35 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)) 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:05:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05:35 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 20:05:35 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 20:05:35 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 20:05:35 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 20:05:35 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 20:05:35 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 20:05:37 INFO - Downloading blessings-1.6.tar.gz 20:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:05:37 INFO - Installing collected packages: blessings 20:05:37 INFO - Running setup.py install for blessings 20:05:37 INFO - Successfully installed blessings 20:05:37 INFO - Cleaning up... 20:05:37 INFO - Return code: 0 20:05:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:38 INFO - Reading from file tmpfile_stdout 20:05:38 INFO - Current package versions: 20:05:38 INFO - argparse == 1.2.1 20:05:38 INFO - blessings == 1.6 20:05:38 INFO - blobuploader == 1.2.4 20:05:38 INFO - docopt == 0.6.1 20:05:38 INFO - functools32 == 3.2.3-2 20:05:38 INFO - jsonschema == 2.5.1 20:05:38 INFO - manifestparser == 1.1 20:05:38 INFO - mozInstall == 1.12 20:05:38 INFO - mozcrash == 0.17 20:05:38 INFO - mozdebug == 0.1 20:05:38 INFO - mozdevice == 0.48 20:05:38 INFO - mozfile == 1.2 20:05:38 INFO - mozhttpd == 0.7 20:05:38 INFO - mozinfo == 0.9 20:05:38 INFO - mozleak == 0.1 20:05:38 INFO - mozlog == 3.4 20:05:38 INFO - moznetwork == 0.27 20:05:38 INFO - mozprocess == 0.23 20:05:38 INFO - mozprofile == 0.28 20:05:38 INFO - mozrunner == 6.12 20:05:38 INFO - mozscreenshot == 0.1 20:05:38 INFO - mozsystemmonitor == 0.3 20:05:38 INFO - moztest == 0.7 20:05:38 INFO - mozversion == 1.4 20:05:38 INFO - psutil == 3.1.1 20:05:38 INFO - requests == 1.2.3 20:05:38 INFO - wsgiref == 0.1.2 20:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:05:38 INFO - Using env: {'DISPLAY': ':0', 20:05:38 INFO - 'HOME': '/home/cltbld', 20:05:38 INFO - 'LANG': 'en_US.UTF-8', 20:05:38 INFO - 'LANGUAGE': 'en_US:en', 20:05:38 INFO - 'LOGNAME': 'cltbld', 20:05:38 INFO - 'MAIL': '/var/mail/cltbld', 20:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:38 INFO - 'MOZ_NO_REMOTE': '1', 20:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:38 INFO - 'NO_EM_RESTART': '1', 20:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:38 INFO - 'PWD': '/builds/slave/test', 20:05:38 INFO - 'SHELL': '/bin/bash', 20:05:38 INFO - 'SHLVL': '1', 20:05:38 INFO - 'TERM': 'linux', 20:05:38 INFO - 'TMOUT': '86400', 20:05:38 INFO - 'USER': 'cltbld', 20:05:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:38 INFO - '_': '/tools/buildbot/bin/python'} 20:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:05:38 INFO - Cleaning up... 20:05:38 INFO - Return code: 0 20:05:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33bef00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', '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 20:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:05:38 INFO - Using env: {'DISPLAY': ':0', 20:05:38 INFO - 'HOME': '/home/cltbld', 20:05:38 INFO - 'LANG': 'en_US.UTF-8', 20:05:38 INFO - 'LANGUAGE': 'en_US:en', 20:05:38 INFO - 'LOGNAME': 'cltbld', 20:05:38 INFO - 'MAIL': '/var/mail/cltbld', 20:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:38 INFO - 'MOZ_NO_REMOTE': '1', 20:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:38 INFO - 'NO_EM_RESTART': '1', 20:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:38 INFO - 'PWD': '/builds/slave/test', 20:05:38 INFO - 'SHELL': '/bin/bash', 20:05:38 INFO - 'SHLVL': '1', 20:05:38 INFO - 'TERM': 'linux', 20:05:38 INFO - 'TMOUT': '86400', 20:05:38 INFO - 'USER': 'cltbld', 20:05:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:38 INFO - '_': '/tools/buildbot/bin/python'} 20:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:05:38 INFO - Cleaning up... 20:05:38 INFO - Return code: 0 20:05:38 INFO - Running post-action listener: _resource_record_post_action 20:05:38 INFO - Running post-action listener: _start_resource_monitoring 20:05:38 INFO - Starting resource monitoring. 20:05:38 INFO - [mozharness: 2016-11-01 03:05:38.547219Z] Finished create-virtualenv step (success) 20:05:38 INFO - [mozharness: 2016-11-01 03:05:38.547729Z] Running install step. 20:05:38 INFO - Running pre-action listener: _resource_record_pre_action 20:05:38 INFO - Running main action method: install 20:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:38 INFO - Reading from file tmpfile_stdout 20:05:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:05:38 INFO - Reading from file tmpfile_stdout 20:05:38 INFO - Output received: 20:05:38 INFO - Usage: mozinstall [options] installer 20:05:38 INFO - Options: 20:05:38 INFO - -h, --help show this help message and exit 20:05:38 INFO - -d DEST, --destination=DEST 20:05:38 INFO - Directory to install application into. [default: 20:05:38 INFO - "/builds/slave/test"] 20:05:38 INFO - --app=APP Application being installed. [default: firefox] 20:05:38 INFO - mkdir: /builds/slave/test/build/application 20:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:05:55 INFO - Reading from file tmpfile_stdout 20:05:55 INFO - Output received: 20:05:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:05:55 INFO - Running post-action listener: _resource_record_post_action 20:05:55 INFO - [mozharness: 2016-11-01 03:05:55.440558Z] Finished install step (success) 20:05:55 INFO - [mozharness: 2016-11-01 03:05:55.440807Z] Running run-tests step. 20:05:55 INFO - Running pre-action listener: _resource_record_pre_action 20:05:55 INFO - Running main action method: run_tests 20:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:05:55 INFO - Python 2.7.3 20:05:55 INFO - Return code: 0 20:05:55 INFO - grabbing minidump binary from tooltool 20:05:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:55 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653f60>, '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 0x2654d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26551d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:05:55 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 20:05:55 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 20:05:55 INFO - Calling ['/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'] with output_timeout 600 20:05:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:05:55 INFO - Return code: 0 20:05:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:05:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:05:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:05:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:05:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:05:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:05:55 INFO - mozversion application_buildid: 20161031183902 20:05:55 INFO - mozversion application_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:05:55 INFO - mozversion application_display_name: Nightly 20:05:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:05:55 INFO - mozversion application_name: Firefox 20:05:55 INFO - mozversion application_remotingname: firefox 20:05:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:05:55 INFO - mozversion application_vendor: Mozilla 20:05:55 INFO - mozversion application_version: 52.0a1 20:05:55 INFO - mozversion platform_buildid: 20161031183902 20:05:55 INFO - mozversion platform_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:05:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:05:55 INFO - mozversion platform_version: 52.0a1 20:05:55 INFO - using testdate: 1477969555 20:05:55 INFO - actual date: 1477969555 20:05:55 INFO - starting webserver on 'localhost:52803' 20:05:55 INFO - SUITE-START | Running 2 tests 20:05:55 INFO - TEST-START | dromaeo_css 20:05:55 INFO - operating with platform_type : linux_ 20:05:55 INFO - Initialising browser for dromaeo_css test... 20:05:55 INFO - TEST-INFO | started process 1879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIAv4w/profile http://localhost:52803/getInfo.html) 20:06:00 INFO - PROCESS | 1879 | __metrics Screen width/height:1600/1200 20:06:00 INFO - PROCESS | 1879 | colorDepth:24 20:06:00 INFO - PROCESS | 1879 | Browser inner width/height: 1024/697 20:06:00 INFO - PROCESS | 1879 | __metrics 20:06:00 INFO - PROCESS | 1879 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:06:00 INFO - PROCESS | 1879 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:01 INFO - PROCESS | 1879 | console.error: PushService: 20:06:01 INFO - PROCESS | 1879 | stateChangeProcessEnqueue: Error transitioning state 20:06:01 INFO - PROCESS | 1879 | UnknownError 20:06:02 INFO - TEST-INFO | 1879: exit 0 20:06:02 INFO - Browser initialized. 20:06:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:02 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIAv4w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:14 INFO - PROCESS | 1958 | RSS: Main: 174510080 20:06:14 INFO - PROCESS | 1958 | 20:07:06 INFO - PROCESS | 1958 | 1477969626266 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] 20:09:20 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52803/tests/dromaeo/cssquery-ext.html) 20:09:21 INFO - PROCESS | 1958 | RSS: Main: 308363264 20:09:21 INFO - PROCESS | 1958 | 20:12:24 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-ext.html (next: http://localhost:52803/tests/dromaeo/cssquery-jquery.html) 20:12:25 INFO - PROCESS | 1958 | RSS: Main: 278794240 20:12:25 INFO - PROCESS | 1958 | 20:15:27 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52803/tests/dromaeo/cssquery-mootools.html) 20:15:28 INFO - PROCESS | 1958 | RSS: Main: 220848128 20:15:28 INFO - PROCESS | 1958 | 20:18:30 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52803/tests/dromaeo/cssquery-prototype.html) 20:18:31 INFO - PROCESS | 1958 | RSS: Main: 249225216 20:18:31 INFO - PROCESS | 1958 | 20:21:34 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52803/tests/dromaeo/cssquery-yui.html) 20:21:34 INFO - PROCESS | 1958 | RSS: Main: 222023680 20:21:34 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-yui.html (next: http://localhost:52803/tests/dromaeo/cssquery-dojo.html) 20:24:37 INFO - PROCESS | 1958 | RSS: Main: 311857152 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | __start_tp_report 20:24:37 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 20:24:37 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 20:24:37 INFO - PROCESS | 1958 | |i|pagename|runs| 20:24:37 INFO - PROCESS | 1958 | |0;dojo.html;2561.974380256197;2577.471618318245;2608.334874606975;2623.0819213275354;2630.631711560382;4603.976980115095;4665.556772106653;4688.812447502096;4714.740689262089;4722.126406614774;4658;4668.136394766971;4689.648276379268;4699.812007519704;4701.576858082772;4314.15873904588;4344.370066340379;4353.325234588644;4388.846390376338;4433.86698399047;4387.363832244323;4402.185595664796;4426.159029784347;4430.136123455927;4432.534583868695;4316.97841510792;4337.240982828008;4360.6075453209205;4376.584224498668;4421.358902959069;4387.758673272969;4425.623821975136;4426.645868330525;4442.289233722605;4478.104379124188;4216.7259128156875;4250.87247382576;4267.637250833652;4349.043210493686;4349.7825108744755;4627.14397836398;4637.814487420499;4638.698484598491;4651.046535460257;4705.741184234866;4976.626752993504;4989.451160372356;5034.471380505068;5038.042771873333;5076.695398276115;4937.629677774181;5038.974805125951;5067.619928505377;5069.873253168664;5129.12804823181;4647.721136731807;4681.95318046822;4710.9764451177525;4739.905201895943;4745.169595320874;5173.896522069537;5180.585553155738;5195.9740201298755;5200.19396993459;5201.227915677808;4948.233023881304;4972.900541989212;4981.402231732215;4984;5029.421616514148;4919.089968355794;4974.452810190876;4975.950240497548;4993.925091123636;5038.2190760432195;4999.350084488993;5055.8988820223385;5058.342415486037;5060.898782024413;5061.468545802638;4928.531789479994;4969.726665033458;4978.90042199154;4982.10322142018;5043.067032598981;4169.1661667666585;4209;4270.743755374688;4283.828646854091;4318.460192475941;3707.888763337104;3730.6082861299174;3752.605976372496;3759.154190307159;3829.8468061277795;4322.481302243688;4323.156984388077;4324.718893271927;4327.394164816928;4380.7152535085115;5036.345275114211;5059.392872855281;5061.949380506221;5083.796648134107;5121.667091639106;4213.157368526307;4265.338872474771;4271.145770845843;4324.589164029412;4330.913381732347;4555;4561.794719237642;4563.954360456353;4587.7017993830295;4620.2607582786595;4766.094442056067;4772.141014617402;4777.426708794827;4779.784909679003;4839.879003024953;4892.363992680928;4918.2376731606655;4962.082014827269;4966.950330496648;5067.797288108434;4711.481737008995;4767.761611919321;4785.066911952136;4793.95206047949;4795.472498025145;4957.752112394438;4961.454240033521;4963.950360496493;4970.533692560775;5028.522290382408;4998.1003419383405;5032.220005899091;5042.647014708935;5044.218146187347;5097.490250974873;4759.14335419614;4815.807367705253;4834.250691142878;4877.219644856806;4975.203967365204;4844.903101938012;4868.318435419115;4890.706557606555;4912.336834527436;4927.753612319298;4822.9758851205515;4823.1800593898415;4826.348442960156;4835.854924352275;4870.95129048705;4827.300041494034;4896.192128298933;4907.631927605373;4908.803647854046;4949.6287778416045;4803.759812009315;4823.324734537237;4858.732769697701;4868.634852386156;4885.022995401005 20:24:37 INFO - PROCESS | 1958 | |1;ext.html;563.2649392542731;563.8984982703113;571.7941541045226;572.9541636669067;586.7564960541373;27994.720052799465;41509.79245103778;42811.78594107029;42813.35779963303;42951.785241073754;39893.20213595726;40335.39496907549;40441.19117617646;40442.39336409956;40502.392464112985;7714.922850771491;7862.410319226053;7864.685412583518;7865.921340786605;7879.645415956267;7567.470277080606;7655.578943158124;7657;7659.961700191491;7664.846703065935;7679.616019199046;7718.382529397635;7720.61396930154;7726.227377262285;7732.420068494857;7656.770296891103;7667.693292268303;7694.961525192394;7697.692092316329;7699.461037727361;7748.302652761278;7750.418718596072;7783.961080194619;7801.297883190483;7805.4536182467255;38630.420543691864;39013;39033.21933561313;39039.21921561581;39084.80457597722;3013.804102733315;3132.859021344045;3173.8889138880027;3173.984130079335;3246.3507298540385;28775.56836647452;28990.71009289901;29021.854890725623;29362;30624.2343941401;3321.4021476134285;3363.2432702641954;3385.6783605557434;3418.179636887154;3424.9828750856086;239571;240028;240904;240913;241030.99999999825;31765.841170794;52087.73956130271;52480;52483.21275180799;52544.474555254725;32213.677863221536;34148.82925585356;34212.31575368528;34213.48679769805;34250;13464.730705386033;13595.320233988261;13599.184048957095;13600.115992460458;13605.571415001481;11335.376554289593;11353;11353.432328383547;11360.886391135982;11361.659150225507;7933.444658873939;7945.920540794634;7980.880286795703;8011.078725946474;8036.276735093869;3109.7356724678657;3145.213696575856;3148.826814525223;3168.477201261766;3180.538821870816;852.2542775071812;856.4219152072326;919.5310391700281;955.3455882720359;959.7216807125994;27317.863410682818;27912.86043569769;28011.439771204463;28111;28726.569101463494;913.8126684029891;981.5582987655583;1030.5002073994108;1042.6871938418444;1045.513836066233;14228;14905.403783848742;15070.773938390932;15237.695246095016;15411.075335479907;371757;374077;376240;376732;376819;48919.26621100686;49433;49451.752741236065;49658.50341496611;49710.25434618483;1059.941703206331;1097.4786976186408;1130.6438471881331;1170.9004734597654;1191.7378176801262;25827.483450330514;27985.440291193656;28575.27780411275;29828.850855745583;29954.550681740227;43507.78246108749;48236.517634823205;48261;48310.27534586914;48337.516624833304;328907;333974;334176;334918;335310.1751859894;31882;32763;35584.11039724028;36470.452943205346;38317.80841095777;40691.18617627572;41111.38332924949;41280.1743965113;41892.58107418887;42227;34443.31113377668;34607.65392346044;34906.47640285347;34994;35269.47095793514;34255.65744342525;34603.30793384169;35309.646903530636;35494.29011419809;35503;34658.48012279868;35051.29897402089;35298.11754706153;35561.288774224886;35841;29967.400651987275;31488.212794680316;31976.68023319737;32070.518942215418;32225.838870805495;24415.633765493178;24900.875495622407;24926.252212433657;25377;25386.238412847644 20:24:37 INFO - PROCESS | 1958 | |2;jquery.html;343.84698809029993;365.33873688623595;370.54052974311855;375.70882566011346;384.0935392473763;12436.502539898405;13003.154794938335;15928.203589820492;16777.66444671106;16919.06945118021;16295.185240737976;16854;16861.83138168621;16980.660386792286;16985.3205871765;4559.384483094789;4986.5013498650205;5030.647854650176;5037;5043.041822053798;3636.181859081712;3821.5796262411113;4919.901601967958;5016.824411145611;5632.915506267409;5951.315598706161;5980.700964951735;5981.102834574827;5986.640801551921;6000.699965001754;5685.77256909721;5830.154627578977;5854.5023672987845;5859.824205273806;5955.3449120596915;5110.28456016158;5112.616553758483;5115.846524604268;5121.692698438105;5122.743862806845;20801.89599051995;20973.68539471909;21004;21067.8946605266;21134;1926.3257859748976;1939.4763413878316;1948.2207117153112;1981.782003979561;1982.623301572711;12449;13248.801267980987;13525.120867143603;13832.515861944783;13993.300334983312;1656.7266401043814;1663.3346661335443;1683.2761912377673;1727.041491971955;1787.240422820296;43210.351844722354;46801.76599117017;62712.68643656753;62841;65766.34233657698;9419.199368053793;9446.95276523613;9862;9888.406695598143;10035.899641003643;13465.596032119052;13482.797758033637;13503.12229705066;13504.189748615114;13512.729745405037;7253.963730181421;7284.125904891341;7398.815029624195;7594.96202518995;7596.126445458733;7220.9638951805955;7232.566046037149;7259.237780033126;7430.851382972419;7443.255674432622;4069.4302797608357;4104.712670113064;4127.8968025799595;4135.875923722233;4258.787060646955;1709.290644382592;1831.3407173417559;1864.7202919561903;1870.990645046766;1888.8772229805293;670.6750745466062;811.2293321344628;822.9012518497699;841.4488510025943;845.6236974546268;16244.918775406048;16690.666186676197;17437.302507899796;17614;17695.203715832817;806.1535387842741;836.3476488339105;842.2714352085402;856.9689835090875;866.7703058689452;9243.584038718274;9520.523973801282;9802.607895684236;9817;9982.450965196838;383777;389365;396415;396552.51712242817;398568;45904.540954590695;46413.76793116013;46749.29876051862;48881.755591221816;73449.2655073453;900.1943260781695;904.5160838951261;929.3076657889916;929.8605209218535;930.7207837648814;15108.622284442978;15178.696426071638;15468.613284667974;15878.841211588198;15975.20123993819;35360.29279414449;35407.29185416226;36082.8195859019;36301.818490907375;36356.81821590875;48626;48769;48870;50002.49997499979;51102.23346649878;6527.5757075789925;6731.596104233761;6748.831279218059;7652.885206721792;7796.298333150044;10927.781444371227;11073.390963497084;11715.238509496856;12232.877671223174;12614.495420183457;10155.847662284923;10374.896251037393;10611.469426528796;10632.627858024933;10903.727406814893;10001;10007.699769006942;10299.742506437398;10302.175825934057;10336;5412.485813847678;5785.971070144622;9499.767554624796;10223;10670.89329106699;7390.782765170535;7472.701091956261;7719.768406947801;7746.845063098819;7838.137804841349;8577.82844343122;10464.110550603284;10581.629642962767;10618.256722029384;11071.391073491035 20:24:37 INFO - PROCESS | 1958 | |3;mootools.html;1303.2115570080102;1375.2985977151652;1427.4932398998355;1653.2312474699263;1681.1258145764211;6252.6561039142825;6709.563878347904;6717.3618506241955;6719.193696756384;6734.52858299918;5856.648601083938;6070.453659170674;6508.349165083489;6698.631575263371;6701.430378417828;2071.7099606055126;2087.3946555498887;2095.4866057815857;2098.3600001999384;2098.9055492502875;2056.516718571135;2098.7166732491146;2099.338708306886;2121.5226574020876;2128.0849234829016;1795.1293622593032;1841.2542920117373;1923.3556758485925;1960.2746983616082;2067.1008111471483;2002.1590931808603;2014.979850201494;2018.6971954206986;2020.7170996060563;2024.331970449748;1969.4583989402886;1973.250164937329;1981.8018198180212;2008.1465377214624;2013.9697904531297;6739.292374300677;6869.0383346331555;6871.03805467235;6888.345607167311;6902.965485172542;4241.745495270263;4366.345048242789;4367.67242456817;4371.322445021026;4372.322290045048;2703.9594406083925;2780.7358300961578;2806.9157925262275;2819.6898341182455;2874.1664917173994;918.081918081918;945.0785484152965;953.4565297780268;964.2334344196381;974.6491263145263;8980.191782739585;9039.502827344493;9046.592903319366;9056.411333263317;9061.139191776836;3724.5530536335814;3817.0648191193336;3893.162969961472;3905.4727611772614;3980.402939559089;7806.1413244543055;7806.453548251681;7809.297163255221;7813.609319534001;7825.082854700635;4339.132173565299;4342;4345.9348109778375;4349.173657005159;4349.739015659071;3858.228354329089;3962.3660214365564;3964.0288129408477;3966.8214930328204;3967.484227050523;3274.8526316315824;3283.3761585298716;3335.7498187636024;3370;3384.0693809202176;1158.9942050289694;1173.5305877648839;1183.7573297474169;1189.7323102301914;1192.9761404771857;757.5189754505928;783.804048987753;787.2757063501592;831.3681601982416;840.7729912923477;4658.906821863544;4868.537488938545;4910.926336104962;4919.852404427873;5113.616478764033;419.67684882640805;419.83626385709596;421.4373810962338;422.54576330444894;423.13257821465874;3283.113559338965;3306.3056758080593;3312.7349812015464;3334.5164951082443;3414.573178352706;7843.098043725045;8102.108768035511;8223.342132629376;8231.218034286852;8254.752357429286;8173.346132309401;8174.632141553644;8175.550344731097;8180.345572354197;8191.467554608931;6325;6418.871622567616;6419.1334169887405;6428.067930150102;6442.35576442352;4668.299755036635;4685.625149988061;4742.502037286035;4783.6412269079265;4808.134535783593;7361.337479626859;7407;7582.772516824504;7634.427417943787;7669.808254793452;7529.58587277705;7588.430867685056;7651.655675494505;7711.1517733048195;7720.382369410546;5776.277965254343;5800.564957628279;5898.4101589840675;5950.3454619992635;6018.428249316308;6668.166479190101;6700.497462690415;6704.262531121475;6719.26088130315;6719.630420326929;5890.087036509348;5926.762929482945;5996.190514280516;6033.215681961317;6096.512279017757;5898;5900.675462849585;5930.466258036798;5937.011101281119;5967.403259673998;5792.913106303493;5887.499562537232;5893.233879595625;5895.29256489224;5899.410058994238;4151.252774500619;4163.084121493267;4279.272523671046;4287.292596721506;4298.333758267474;4144.772037537964;4152.356384760367;4204.810783514688;4226.746395216297;4348.173846969065 20:24:37 INFO - PROCESS | 1958 | |4;prototype.html;284.2141478811089;303.50074128059356;304.41400304414003;311.1660749192165;315.0658298145998;4553.612942899853;4610.4467463904375;4666.883327916804;4697.735074123486;4824.638152138595;4678.251479763238;4757;4786.4974177711365;4790.496997815223;4808.951910480894;3756.4365345198303;3767.9434808477895;3784.6972242220554;3796.7721936683747;3805.067758399196;3626.4560315952685;3784.9053773655605;3790.810459477029;3792.2984247914223;3797.810109494528;3637.4725664778593;3699.149195684994;3730.5709843367954;3778;3792.6396992285827;3767.416050512175;3779.640934111255;3780.111673756665;3787.280416720842;3798.90502737431;3323.4682450807754;3357.227837597342;3372.15696075981;3375.240570871534;3388;4479.5296493868;4627.431775364671;4678.157931572316;4679.60223381013;4680;4270.850520231808;4278.358246263086;4285.1429714057;4288.9920868595855;4290.034742183015;4980.277859710358;4987.850364489072;4988.5260900214425;5004.848884756527;5013.924791128136;3352.7988320700592;3620.294042661682;3634.3821550336506;3641.3445579795625;3643.890683279479;5144.254083157921;5188.403333616645;5189.610779191538;5212.661177023481;5224.451432599561;3626.202235508184;3628.32875917956;3638.1086633774366;3648.1609229877276;3651.342758303531;3677.8161091945294;3679.8344074516713;3683.37382644951;3702.129999450127;3702.6675991607767;4081.3265811140827;4136.358864376027;4189.141226048653;4192.763134875219;4196.895077623023;4931.18635425158;4937.925931111036;4942.481039490802;4955.628327875424;4959.437777100202;1244.7821631214501;1265.569706299844;1266.7593157300084;1267.7147641780525;1267.9429425675867;740.7629558541323;789.960501974899;798.9241022102891;799.4563696686193;800.0159803441683;3921.3333733265413;3921.8823435296986;3928.46965659638;3939.3893946438347;3955.259685738266;4511.05267893746;4523.88690282739;4529.547045295444;4530.097359109116;4531.737149252533;3923.5684074751753;3937.2322397132284;3943.3099207638547;3955.307821131348;3955.3473676843;2334.8715820630027;2398.6042303020154;2427.939301517441;2430.586800243963;2435.2572465398225;4245.724027938174;4276.743395396286;4280.315149576115;4311.965128369169;4316.460442444694;4555.908881822345;4567.858035491127;4592.747398893026;4606.401167848226;4610.654200934876;4089.3048181809163;4269.658427325744;4307.8492252771;4316.525182229952;4318.352247162888;4485.596296333346;4496.7077139985795;4501.41481607389;4504.729716217037;4511.842085526991;4447.266201076786;4451.732896026248;4457.710248833815;4466.352378905106;4796;4763.333133361401;4769.713817170981;4868.440129385024;4886.534039787978;4891.144049791344;3637.199816040467;3638.363286424812;3643.981780091083;3649.4160934250394;3656.5246517952496;5010.36748357438;5186.222066690027;5187.688738675692;5193.4027586828;5195.558377537952;4964.156093464047;4976.651634385558;5006.749662516932;5009.298698182184;5014.473480284518;4976.138720235806;4988.575971042502;5000.024990128806;5014.774335154853;5024.42219144803;4717.410323709536;4934.55588996992;4949.307097006494;4955.727434990966;4965.726885021359;4998.2502624606595;5036.169032109661;5036.496350365081;5042.697438153723;5052.444231134646;4924.433690125681;4927.310176575211;4940.135476291706;4955.50444955516;4963.875903102451 20:24:37 INFO - PROCESS | 1958 | |5;yui.html;675.3145557259379;682.7200847652464;718.8885722712978;732.5568031341038;749.7038669725457;12143.149979501439;13318.800217996726;13330.60008199753;13333.7999930001;13427.798583021262;12491.812622810665;12569.245845249268;12570.30863302518;12619.24284542928;12663.430145643446;617.3857012272795;628.6228263042161;779.0923574036241;788.7318311773996;789.4118881433341;766.6741634805213;777.996110019452;792.4492477727981;797.8922845415852;798.1419973528451;829.2163905109644;829.7469271872106;831.538496134645;831.6673330667751;832.7418500264937;641.9518536109811;655.4985436141355;824.7938015496126;825.7110011495959;825.7233826668073;485.82267472372683;485.83967290794305;486.51105638832746;587.5769445998874;597.2951916738247;12211.450484728208;12291.446884890202;12292.75414491714;12301.630951071482;12317.384130793425;11792.056635469142;11947.522099116024;12221.755564888741;12329.075319351085;12365.14522821575;11058.723531911766;11093.16801239902;11341.546338146465;11414.14393920451;11814.586489472827;4016.5380981187245;4043.2924238258483;4097.180563887205;4141.295979683431;4150.481189851269;48129.75935120337;48282.75758636198;48288.517114829105;48367.274490882664;48367.274490882664;8884.540898836109;9013.143751343612;9191.816163676824;9301.441913485212;9392.953035234917;15821.920890395475;15931.761023584655;16029.839701602834;16036.75944860828;16051.277692503865;6516;6592.472602191813;6727.317921948795;6770.32296770319;6807.897881531781;3340.448825943692;3433.9484907726405;3461.8442170102408;3474.756767026284;3584.0143960411096;2553.323369307135;2653.840769553833;2658.1361057655954;2658.720834312408;3033.6966303369927;534.4628648208526;536.3510152715259;540.2571464236675;540.8972295263966;551.41274542612;585.411661280419;586.6978506069378;635.8808497045234;645.0646562484417;651.9210706281112;7969.920300797034;8142.959285203655;8187.959060204661;8250.38122140842;8252.876206856901;600.9178197545526;611.5476937480735;617.6325086573481;631.9684015799191;648.1800522339245;3927.410888366711;4017.2568074906235;4083.571225021389;4098.7950602469755;4131.958680413218;40145;50606.74696626493;71022.64488677523;75223.62388188024;75395.62302188564;41806.79096604497;42218.78890605527;62130;64742.67628661827;66324.6683766578;58245.70877145587;58415.70792146012;58483;58864.7056764722;59797.70101149466;7457.850842983218;7586.810329741801;7656.578888161204;7710.8843367350655;8023.318017968538;38114.61885381111;38543.42184867173;38609.42085868658;39090.609093909836;39802.60197397989;37492.43761343636;54261;54405.45594544004;54908.725456372464;57062.714686426305;9609.298807794254;9634.662786802428;9817.165540929102;9972.202223822222;10174.593016279561;11181.105511559219;11181.888181118085;11228;11283.435828208392;11286.379249141377;10406.323588966692;10528.684139475828;10561.63034293796;10566.418846963183;10589.894101059199;10537.736556586147;10539.894601054199;10583.5237414315;10611.469426528796;10905.56377744913;9715.757106072404;9801.11789938909;9865.408075515492;9911.10800027972;10465.633702820365;9804.754881128029;9970.800583988135;10055.497225138568;10121.645742398981;10230.846537302095;10131.696049118538;10224.897751022394;10294.536745846304;10360.533775979948;10459.215558832966 20:24:37 INFO - PROCESS | 1958 | __end_tp_report 20:24:37 INFO - PROCESS | 1958 | __start_cc_report 20:24:37 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,1367 20:24:37 INFO - PROCESS | 1958 | __end_cc_report 20:24:37 INFO - PROCESS | 1958 | __startTimestamp1477970677687__endTimestamp 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | ------- Summary: start ------- 20:24:37 INFO - PROCESS | 1958 | Number of tests: 6 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:4653.70 Median:4785.07 stddev:485.40 (10.1%) stddev-sans-first:458.31 20:24:37 INFO - PROCESS | 1958 | Values: 2562.0 2577.5 2608.3 2623.1 2630.6 4604.0 4665.6 4688.8 4714.7 4722.1 4658.0 4668.1 4689.6 4699.8 4701.6 4314.2 4344.4 4353.3 4388.8 4433.9 4387.4 4402.2 4426.2 4430.1 4432.5 4317.0 4337.2 4360.6 4376.6 4421.4 4387.8 4425.6 4426.6 4442.3 4478.1 4216.7 4250.9 4267.6 4349.0 4349.8 4627.1 4637.8 4638.7 4651.0 4705.7 4976.6 4989.5 5034.5 5038.0 5076.7 4937.6 5039.0 5067.6 5069.9 5129.1 4647.7 4682.0 4711.0 4739.9 4745.2 5173.9 5180.6 5196.0 5200.2 5201.2 4948.2 4972.9 4981.4 4984.0 5029.4 4919.1 4974.5 4976.0 4993.9 5038.2 4999.4 5055.9 5058.3 5060.9 5061.5 4928.5 4969.7 4978.9 4982.1 5043.1 4169.2 4209.0 4270.7 4283.8 4318.5 3707.9 3730.6 3752.6 3759.2 3829.8 4322.5 4323.2 4324.7 4327.4 4380.7 5036.3 5059.4 5061.9 5083.8 5121.7 4213.2 4265.3 4271.1 4324.6 4330.9 4555.0 4561.8 4564.0 4587.7 4620.3 4766.1 4772.1 4777.4 4779.8 4839.9 4892.4 4918.2 4962.1 4967.0 5067.8 4711.5 4767.8 4785.1 4794.0 4795.5 4957.8 4961.5 4964.0 4970.5 5028.5 4998.1 5032.2 5042.6 5044.2 5097.5 4759.1 4815.8 4834.3 4877.2 4975.2 4844.9 4868.3 4890.7 4912.3 4927.8 4823.0 4823.2 4826.3 4835.9 4871.0 4827.3 4896.2 4907.6 4908.8 4949.6 4803.8 4823.3 4858.7 4868.6 4885.0 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:46405.53 Median:35283.79 stddev:84704.23 (240.1%) stddev-sans-first:84871.92 20:24:37 INFO - PROCESS | 1958 | Values: 563.3 563.9 571.8 573.0 586.8 27994.7 41509.8 42811.8 42813.4 42951.8 39893.2 40335.4 40441.2 40442.4 40502.4 7714.9 7862.4 7864.7 7865.9 7879.6 7567.5 7655.6 7657.0 7660.0 7664.8 7679.6 7718.4 7720.6 7726.2 7732.4 7656.8 7667.7 7695.0 7697.7 7699.5 7748.3 7750.4 7784.0 7801.3 7805.5 38630.4 39013.0 39033.2 39039.2 39084.8 3013.8 3132.9 3173.9 3174.0 3246.4 28775.6 28990.7 29021.9 29362.0 30624.2 3321.4 3363.2 3385.7 3418.2 3425.0 239571.0 240028.0 240904.0 240913.0 241031.0 31765.8 52087.7 52480.0 52483.2 52544.5 32213.7 34148.8 34212.3 34213.5 34250.0 13464.7 13595.3 13599.2 13600.1 13605.6 11335.4 11353.0 11353.4 11360.9 11361.7 7933.4 7945.9 7980.9 8011.1 8036.3 3109.7 3145.2 3148.8 3168.5 3180.5 852.3 856.4 919.5 955.3 959.7 27317.9 27912.9 28011.4 28111.0 28726.6 913.8 981.6 1030.5 1042.7 1045.5 14228.0 14905.4 15070.8 15237.7 15411.1 371757.0 374077.0 376240.0 376732.0 376819.0 48919.3 49433.0 49451.8 49658.5 49710.3 1059.9 1097.5 1130.6 1170.9 1191.7 25827.5 27985.4 28575.3 29828.9 29954.6 43507.8 48236.5 48261.0 48310.3 48337.5 328907.0 333974.0 334176.0 334918.0 335310.2 31882.0 32763.0 35584.1 36470.5 38317.8 40691.2 41111.4 41280.2 41892.6 42227.0 34443.3 34607.7 34906.5 34994.0 35269.5 34255.7 34603.3 35309.6 35494.3 35503.0 34658.5 35051.3 35298.1 35561.3 35841.0 29967.4 31488.2 31976.7 32070.5 32225.8 24415.6 24900.9 24926.3 25377.0 25386.2 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:23281.77 Median:4116.30 stddev:64234.27 (1560.5%) stddev-sans-first:64391.37 20:24:37 INFO - PROCESS | 1958 | Values: 343.8 365.3 370.5 375.7 384.1 12436.5 13003.2 15928.2 16777.7 16919.1 16295.2 16854.0 16861.8 16980.7 16985.3 4559.4 4986.5 5030.6 5037.0 5043.0 3636.2 3821.6 4919.9 5016.8 5632.9 5951.3 5980.7 5981.1 5986.6 6000.7 5685.8 5830.2 5854.5 5859.8 5955.3 5110.3 5112.6 5115.8 5121.7 5122.7 20801.9 20973.7 21004.0 21067.9 21134.0 1926.3 1939.5 1948.2 1981.8 1982.6 12449.0 13248.8 13525.1 13832.5 13993.3 1656.7 1663.3 1683.3 1727.0 1787.2 43210.4 46801.8 62712.7 62841.0 65766.3 9419.2 9447.0 9862.0 9888.4 10035.9 13465.6 13482.8 13503.1 13504.2 13512.7 7254.0 7284.1 7398.8 7595.0 7596.1 7221.0 7232.6 7259.2 7430.9 7443.3 4069.4 4104.7 4127.9 4135.9 4258.8 1709.3 1831.3 1864.7 1871.0 1888.9 670.7 811.2 822.9 841.4 845.6 16244.9 16690.7 17437.3 17614.0 17695.2 806.2 836.3 842.3 857.0 866.8 9243.6 9520.5 9802.6 9817.0 9982.5 383777.0 389365.0 396415.0 396552.5 398568.0 45904.5 46413.8 46749.3 48881.8 73449.3 900.2 904.5 929.3 929.9 930.7 15108.6 15178.7 15468.6 15878.8 15975.2 35360.3 35407.3 36082.8 36301.8 36356.8 48626.0 48769.0 48870.0 50002.5 51102.2 6527.6 6731.6 6748.8 7652.9 7796.3 10927.8 11073.4 11715.2 12232.9 12614.5 10155.8 10374.9 10611.5 10632.6 10903.7 10001.0 10007.7 10299.7 10302.2 10336.0 5412.5 5786.0 9499.8 10223.0 10670.9 7390.8 7472.7 7719.8 7746.8 7838.1 8577.8 10464.1 10581.6 10618.3 11071.4 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:4554.35 Median:4838.34 stddev:2411.02 (49.8%) stddev-sans-first:2405.41 20:24:37 INFO - PROCESS | 1958 | Values: 1303.2 1375.3 1427.5 1653.2 1681.1 6252.7 6709.6 6717.4 6719.2 6734.5 5856.6 6070.5 6508.3 6698.6 6701.4 2071.7 2087.4 2095.5 2098.4 2098.9 2056.5 2098.7 2099.3 2121.5 2128.1 1795.1 1841.3 1923.4 1960.3 2067.1 2002.2 2015.0 2018.7 2020.7 2024.3 1969.5 1973.3 1981.8 2008.1 2014.0 6739.3 6869.0 6871.0 6888.3 6903.0 4241.7 4366.3 4367.7 4371.3 4372.3 2704.0 2780.7 2806.9 2819.7 2874.2 918.1 945.1 953.5 964.2 974.6 8980.2 9039.5 9046.6 9056.4 9061.1 3724.6 3817.1 3893.2 3905.5 3980.4 7806.1 7806.5 7809.3 7813.6 7825.1 4339.1 4342.0 4345.9 4349.2 4349.7 3858.2 3962.4 3964.0 3966.8 3967.5 3274.9 3283.4 3335.7 3370.0 3384.1 1159.0 1173.5 1183.8 1189.7 1193.0 757.5 783.8 787.3 831.4 840.8 4658.9 4868.5 4910.9 4919.9 5113.6 419.7 419.8 421.4 422.5 423.1 3283.1 3306.3 3312.7 3334.5 3414.6 7843.1 8102.1 8223.3 8231.2 8254.8 8173.3 8174.6 8175.6 8180.3 8191.5 6325.0 6418.9 6419.1 6428.1 6442.4 4668.3 4685.6 4742.5 4783.6 4808.1 7361.3 7407.0 7582.8 7634.4 7669.8 7529.6 7588.4 7651.7 7711.2 7720.4 5776.3 5800.6 5898.4 5950.3 6018.4 6668.2 6700.5 6704.3 6719.3 6719.6 5890.1 5926.8 5996.2 6033.2 6096.5 5898.0 5900.7 5930.5 5937.0 5967.4 5792.9 5887.5 5893.2 5895.3 5899.4 4151.3 4163.1 4279.3 4287.3 4298.3 4144.8 4152.4 4204.8 4226.7 4348.2 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:4021.81 Median:4449.50 stddev:1160.36 (26.1%) stddev-sans-first:1129.20 20:24:37 INFO - PROCESS | 1958 | Values: 284.2 303.5 304.4 311.2 315.1 4553.6 4610.4 4666.9 4697.7 4824.6 4678.3 4757.0 4786.5 4790.5 4809.0 3756.4 3767.9 3784.7 3796.8 3805.1 3626.5 3784.9 3790.8 3792.3 3797.8 3637.5 3699.1 3730.6 3778.0 3792.6 3767.4 3779.6 3780.1 3787.3 3798.9 3323.5 3357.2 3372.2 3375.2 3388.0 4479.5 4627.4 4678.2 4679.6 4680.0 4270.9 4278.4 4285.1 4289.0 4290.0 4980.3 4987.9 4988.5 5004.8 5013.9 3352.8 3620.3 3634.4 3641.3 3643.9 5144.3 5188.4 5189.6 5212.7 5224.5 3626.2 3628.3 3638.1 3648.2 3651.3 3677.8 3679.8 3683.4 3702.1 3702.7 4081.3 4136.4 4189.1 4192.8 4196.9 4931.2 4937.9 4942.5 4955.6 4959.4 1244.8 1265.6 1266.8 1267.7 1267.9 740.8 790.0 798.9 799.5 800.0 3921.3 3921.9 3928.5 3939.4 3955.3 4511.1 4523.9 4529.5 4530.1 4531.7 3923.6 3937.2 3943.3 3955.3 3955.3 2334.9 2398.6 2427.9 2430.6 2435.3 4245.7 4276.7 4280.3 4312.0 4316.5 4555.9 4567.9 4592.7 4606.4 4610.7 4089.3 4269.7 4307.8 4316.5 4318.4 4485.6 4496.7 4501.4 4504.7 4511.8 4447.3 4451.7 4457.7 4466.4 4796.0 4763.3 4769.7 4868.4 4886.5 4891.1 3637.2 3638.4 3644.0 3649.4 3656.5 5010.4 5186.2 5187.7 5193.4 5195.6 4964.2 4976.7 5006.7 5009.3 5014.5 4976.1 4988.6 5000.0 5014.8 5024.4 4717.4 4934.6 4949.3 4955.7 4965.7 4998.3 5036.2 5036.5 5042.7 5052.4 4924.4 4927.3 4940.1 4955.5 4963.9 20:24:37 INFO - PROCESS | 1958 | 20:24:37 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:14374.88 Median:486.18 stddev:18274.05 (3758.7%) stddev-sans-first:18296.35 20:24:37 INFO - PROCESS | 1958 | Values: 675.3 682.7 718.9 732.6 749.7 12143.1 13318.8 13330.6 13333.8 13427.8 12491.8 12569.2 12570.3 12619.2 12663.4 617.4 628.6 779.1 788.7 789.4 766.7 778.0 792.4 797.9 798.1 829.2 829.7 831.5 831.7 832.7 642.0 655.5 824.8 825.7 825.7 485.8 485.8 486.5 587.6 597.3 12211.5 12291.4 12292.8 12301.6 12317.4 11792.1 11947.5 12221.8 12329.1 12365.1 11058.7 11093.2 11341.5 11414.1 11814.6 4016.5 4043.3 4097.2 4141.3 4150.5 48129.8 48282.8 48288.5 48367.3 48367.3 8884.5 9013.1 9191.8 9301.4 9393.0 15821.9 15931.8 16029.8 16036.8 16051.3 6516.0 6592.5 6727.3 6770.3 6807.9 3340.4 3433.9 3461.8 3474.8 3584.0 2553.3 2653.8 2658.1 2658.7 3033.7 534.5 536.4 540.3 540.9 551.4 585.4 586.7 635.9 645.1 651.9 7969.9 8143.0 8188.0 8250.4 8252.9 600.9 611.5 617.6 632.0 648.2 3927.4 4017.3 4083.6 4098.8 4132.0 40145.0 50606.7 71022.6 75223.6 75395.6 41806.8 42218.8 62130.0 64742.7 66324.7 58245.7 58415.7 58483.0 58864.7 59797.7 7457.9 7586.8 7656.6 7710.9 8023.3 38114.6 38543.4 38609.4 39090.6 39802.6 37492.4 54261.0 54405.5 54908.7 57062.7 9609.3 9634.7 9817.2 9972.2 10174.6 11181.1 11181.9 11228.0 11283.4 11286.4 10406.3 10528.7 10561.6 10566.4 10589.9 10537.7 10539.9 10583.5 10611.5 10905.6 9715.8 9801.1 9865.4 9911.1 10465.6 9804.8 9970.8 10055.5 10121.6 10230.8 10131.7 10224.9 10294.5 10360.5 10459.2 20:24:37 INFO - PROCESS | 1958 | -------- Summary: end -------- 20:24:37 INFO - PROCESS | 1958 | 20:24:38 INFO - TEST-INFO | 1958: exit 0 20:24:38 INFO - TEST-OK | dromaeo_css | took 1122990ms 20:24:38 INFO - TEST-START | kraken 20:24:38 INFO - operating with platform_type : linux_ 20:24:38 INFO - Initialising browser for kraken test... 20:24:38 INFO - TEST-INFO | started process 2262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrgbvG/profile http://localhost:52803/getInfo.html) 20:24:42 INFO - PROCESS | 2262 | __metrics Screen width/height:1600/1200 20:24:42 INFO - PROCESS | 2262 | colorDepth:24 20:24:42 INFO - PROCESS | 2262 | Browser inner width/height: 1024/697 20:24:42 INFO - PROCESS | 2262 | __metrics 20:24:43 INFO - PROCESS | 2262 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:24:43 INFO - PROCESS | 2262 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:24:44 INFO - PROCESS | 2262 | console.error: PushService: 20:24:44 INFO - PROCESS | 2262 | stateChangeProcessEnqueue: Error transitioning state 20:24:44 INFO - PROCESS | 2262 | UnknownError 20:24:45 INFO - TEST-INFO | 2262: exit 0 20:24:45 INFO - Browser initialized. 20:24:45 INFO - Running cycle 1/1 for kraken test... 20:24:45 INFO - TEST-INFO | started process 2342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrgbvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:57 INFO - PROCESS | 2342 | RSS: Main: 174485504 20:24:57 INFO - PROCESS | 2342 | 20:25:00 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:01 INFO - PROCESS | 2342 | RSS: Main: 230395904 20:25:01 INFO - PROCESS | 2342 | 20:25:03 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-dft) 20:25:04 INFO - PROCESS | 2342 | RSS: Main: 217305088 20:25:04 INFO - PROCESS | 2342 | 20:25:07 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-fft) 20:25:08 INFO - PROCESS | 2342 | RSS: Main: 300027904 20:25:08 INFO - PROCESS | 2342 | 20:25:10 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator) 20:25:11 INFO - PROCESS | 2342 | RSS: Main: 211070976 20:25:11 INFO - PROCESS | 2342 | 20:25:13 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:14 INFO - PROCESS | 2342 | RSS: Main: 214220800 20:25:14 INFO - PROCESS | 2342 | 20:25:17 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:17 INFO - PROCESS | 2342 | RSS: Main: 249757696 20:25:17 INFO - PROCESS | 2342 | 20:25:21 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:21 INFO - PROCESS | 2342 | RSS: Main: 248471552 20:25:21 INFO - PROCESS | 2342 | 20:25:24 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial) 20:25:25 INFO - PROCESS | 2342 | RSS: Main: 247865344 20:25:25 INFO - PROCESS | 2342 | 20:25:26 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:27 INFO - PROCESS | 2342 | RSS: Main: 210202624 20:25:27 INFO - PROCESS | 2342 | 20:25:29 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:30 INFO - PROCESS | 2342 | RSS: Main: 218341376 20:25:30 INFO - PROCESS | 2342 | 20:25:32 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:32 INFO - PROCESS | 2342 | RSS: Main: 226918400 20:25:32 INFO - PROCESS | 2342 | 20:25:35 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:36 INFO - PROCESS | 2342 | RSS: Main: 234962944 20:25:36 INFO - PROCESS | 2342 | 20:25:39 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:25:39 INFO - PROCESS | 2342 | RSS: Main: 231497728 20:25:39 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52803/tests/kraken/driver.html?testName=ai-astar) 20:25:41 INFO - PROCESS | 2342 | RSS: Main: 281853952 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | __start_tp_report 20:25:41 INFO - PROCESS | 2342 | _x_x_mozilla_page_load 20:25:41 INFO - PROCESS | 2342 | _x_x_mozilla_page_load_details 20:25:41 INFO - PROCESS | 2342 | |i|pagename|runs| 20:25:41 INFO - PROCESS | 2342 | |0;ai-astar;110;118;119;119;120;120;119;121;118;118 20:25:41 INFO - PROCESS | 2342 | |1;audio-beat-detection;162;128;128;171;128;129;129;133;169;129 20:25:41 INFO - PROCESS | 2342 | |2;audio-dft;162;159;160;161;162;163;162;162;161;161 20:25:41 INFO - PROCESS | 2342 | |3;audio-fft;76;87;77;103;77;76;77;76;99;76 20:25:41 INFO - PROCESS | 2342 | |4;audio-oscillator;84;84;120;83;85;85;106;83;83;117 20:25:41 INFO - PROCESS | 2342 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 20:25:41 INFO - PROCESS | 2342 | |6;imaging-darkroom;146;147;146;147;146;147;146;147;146;146 20:25:41 INFO - PROCESS | 2342 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;85;85 20:25:41 INFO - PROCESS | 2342 | |8;json-parse-financial;64;62;64;64;64;66;66;73;64;63 20:25:41 INFO - PROCESS | 2342 | |9;json-stringify-tinderbox;65;67;66;67;66;66;65;67;65;66 20:25:41 INFO - PROCESS | 2342 | |10;stanford-crypto-aes;84;83;84;84;93;84;87;83;89;83 20:25:41 INFO - PROCESS | 2342 | |11;stanford-crypto-ccm;152;145;141;141;154;142;139;139;181;143 20:25:41 INFO - PROCESS | 2342 | |12;stanford-crypto-pbkdf2;175;177;174;173;177;175;177;174;176;177 20:25:41 INFO - PROCESS | 2342 | |13;stanford-crypto-sha256-iterative;69;71;68;69;70;68;69;68;67;70 20:25:41 INFO - PROCESS | 2342 | __end_tp_report 20:25:41 INFO - PROCESS | 2342 | __start_cc_report 20:25:41 INFO - PROCESS | 2342 | _x_x_mozilla_cycle_collect,1953 20:25:41 INFO - PROCESS | 2342 | __end_cc_report 20:25:41 INFO - PROCESS | 2342 | __startTimestamp1477970741968__endTimestamp 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | ------- Summary: start ------- 20:25:41 INFO - PROCESS | 2342 | Number of tests: 14 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#0] ai-astar Cycles:10 Average:118.20 Median:119.00 stddev:3.05 (2.6%) stddev-sans-first:1.05 20:25:41 INFO - PROCESS | 2342 | Values: 110.0 118.0 119.0 119.0 120.0 120.0 119.0 121.0 118.0 118.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:131.00 stddev:18.64 (14.2%) stddev-sans-first:18.09 20:25:41 INFO - PROCESS | 2342 | Values: 162.0 128.0 128.0 171.0 128.0 129.0 129.0 133.0 169.0 129.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 20:25:41 INFO - PROCESS | 2342 | Values: 162.0 159.0 160.0 161.0 162.0 163.0 162.0 162.0 161.0 161.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:10.39 (13.5%) stddev-sans-first:10.76 20:25:41 INFO - PROCESS | 2342 | Values: 76.0 87.0 77.0 103.0 77.0 76.0 77.0 76.0 99.0 76.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.50 stddev:15.14 (18.1%) stddev-sans-first:15.71 20:25:41 INFO - PROCESS | 2342 | Values: 84.0 84.0 120.0 83.0 85.0 85.0 106.0 83.0 83.0 117.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:25:41 INFO - PROCESS | 2342 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:25:41 INFO - PROCESS | 2342 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:25:41 INFO - PROCESS | 2342 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:3.06 (4.8%) stddev-sans-first:3.22 20:25:41 INFO - PROCESS | 2342 | Values: 64.0 62.0 64.0 64.0 64.0 66.0 66.0 73.0 64.0 63.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 20:25:41 INFO - PROCESS | 2342 | Values: 65.0 67.0 66.0 67.0 66.0 66.0 65.0 67.0 65.0 66.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.31 (3.9%) stddev-sans-first:3.47 20:25:41 INFO - PROCESS | 2342 | Values: 84.0 83.0 84.0 84.0 93.0 84.0 87.0 83.0 89.0 83.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:144.00 stddev:12.78 (8.9%) stddev-sans-first:13.46 20:25:41 INFO - PROCESS | 2342 | Values: 152.0 145.0 141.0 141.0 154.0 142.0 139.0 139.0 181.0 143.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 20:25:41 INFO - PROCESS | 2342 | Values: 175.0 177.0 174.0 173.0 177.0 175.0 177.0 174.0 176.0 177.0 20:25:41 INFO - PROCESS | 2342 | 20:25:41 INFO - PROCESS | 2342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 20:25:41 INFO - PROCESS | 2342 | Values: 69.0 71.0 68.0 69.0 70.0 68.0 69.0 68.0 67.0 70.0 20:25:41 INFO - PROCESS | 2342 | -------- Summary: end -------- 20:25:41 INFO - PROCESS | 2342 | 20:25:43 INFO - TEST-INFO | 2342: exit 0 20:25:43 INFO - TEST-OK | kraken | took 64769ms 20:25:43 INFO - SUITE-END | took 1187s 20:25:43 INFO - Completed test suite (00:19:47) 20:25:43 INFO - javascript benchmark 20:25:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.974380256197, 2577.471618318245, 2608.334874606975, 2623.0819213275354, 2630.631711560382, 4603.976980115095, 4665.556772106653, 4688.812447502096, 4714.740689262089, 4722.126406614774, 4658.0, 4668.136394766971, 4689.648276379268, 4699.812007519704, 4701.576858082772, 4314.15873904588, 4344.370066340379, 4353.325234588644, 4388.846390376338, 4433.86698399047, 4387.363832244323, 4402.185595664796, 4426.159029784347, 4430.136123455927, 4432.534583868695, 4316.97841510792, 4337.240982828008, 4360.6075453209205, 4376.584224498668, 4421.358902959069, 4387.758673272969, 4425.623821975136, 4426.645868330525, 4442.289233722605, 4478.104379124188, 4216.7259128156875, 4250.87247382576, 4267.637250833652, 4349.043210493686, 4349.7825108744755, 4627.14397836398, 4637.814487420499, 4638.698484598491, 4651.046535460257, 4705.741184234866, 4976.626752993504, 4989.451160372356, 5034.471380505068, 5038.042771873333, 5076.695398276115, 4937.629677774181, 5038.974805125951, 5067.619928505377, 5069.873253168664, 5129.12804823181, 4647.721136731807, 4681.95318046822, 4710.9764451177525, 4739.905201895943, 4745.169595320874, 5173.896522069537, 5180.585553155738, 5195.9740201298755, 5200.19396993459, 5201.227915677808, 4948.233023881304, 4972.900541989212, 4981.402231732215, 4984.0, 5029.421616514148, 4919.089968355794, 4974.452810190876, 4975.950240497548, 4993.925091123636, 5038.2190760432195, 4999.350084488993, 5055.8988820223385, 5058.342415486037, 5060.898782024413, 5061.468545802638, 4928.531789479994, 4969.726665033458, 4978.90042199154, 4982.10322142018, 5043.067032598981, 4169.1661667666585, 4209.0, 4270.743755374688, 4283.828646854091, 4318.460192475941, 3707.888763337104, 3730.6082861299174, 3752.605976372496, 3759.154190307159, 3829.8468061277795, 4322.481302243688, 4323.156984388077, 4324.718893271927, 4327.394164816928, 4380.7152535085115, 5036.345275114211, 5059.392872855281, 5061.949380506221, 5083.796648134107, 5121.667091639106, 4213.157368526307, 4265.338872474771, 4271.145770845843, 4324.589164029412, 4330.913381732347, 4555.0, 4561.794719237642, 4563.954360456353, 4587.7017993830295, 4620.2607582786595, 4766.094442056067, 4772.141014617402, 4777.426708794827, 4779.784909679003, 4839.879003024953, 4892.363992680928, 4918.2376731606655, 4962.082014827269, 4966.950330496648, 5067.797288108434, 4711.481737008995, 4767.761611919321, 4785.066911952136, 4793.95206047949, 4795.472498025145, 4957.752112394438, 4961.454240033521, 4963.950360496493, 4970.533692560775, 5028.522290382408, 4998.1003419383405, 5032.220005899091, 5042.647014708935, 5044.218146187347, 5097.490250974873, 4759.14335419614, 4815.807367705253, 4834.250691142878, 4877.219644856806, 4975.203967365204, 4844.903101938012, 4868.318435419115, 4890.706557606555, 4912.336834527436, 4927.753612319298, 4822.9758851205515, 4823.1800593898415, 4826.348442960156, 4835.854924352275, 4870.95129048705, 4827.300041494034, 4896.192128298933, 4907.631927605373, 4908.803647854046, 4949.6287778416045, 4803.759812009315, 4823.324734537237, 4858.732769697701, 4868.634852386156, 4885.022995401005], "value": 4622.445089644909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2649392542731, 563.8984982703113, 571.7941541045226, 572.9541636669067, 586.7564960541373, 27994.720052799465, 41509.79245103778, 42811.78594107029, 42813.35779963303, 42951.785241073754, 39893.20213595726, 40335.39496907549, 40441.19117617646, 40442.39336409956, 40502.392464112985, 7714.922850771491, 7862.410319226053, 7864.685412583518, 7865.921340786605, 7879.645415956267, 7567.470277080606, 7655.578943158124, 7657.0, 7659.961700191491, 7664.846703065935, 7679.616019199046, 7718.382529397635, 7720.61396930154, 7726.227377262285, 7732.420068494857, 7656.770296891103, 7667.693292268303, 7694.961525192394, 7697.692092316329, 7699.461037727361, 7748.302652761278, 7750.418718596072, 7783.961080194619, 7801.297883190483, 7805.4536182467255, 38630.420543691864, 39013.0, 39033.21933561313, 39039.21921561581, 39084.80457597722, 3013.804102733315, 3132.859021344045, 3173.8889138880027, 3173.984130079335, 3246.3507298540385, 28775.56836647452, 28990.71009289901, 29021.854890725623, 29362.0, 30624.2343941401, 3321.4021476134285, 3363.2432702641954, 3385.6783605557434, 3418.179636887154, 3424.9828750856086, 239571.0, 240028.0, 240904.0, 240913.0, 241030.99999999825, 31765.841170794, 52087.73956130271, 52480.0, 52483.21275180799, 52544.474555254725, 32213.677863221536, 34148.82925585356, 34212.31575368528, 34213.48679769805, 34250.0, 13464.730705386033, 13595.320233988261, 13599.184048957095, 13600.115992460458, 13605.571415001481, 11335.376554289593, 11353.0, 11353.432328383547, 11360.886391135982, 11361.659150225507, 7933.444658873939, 7945.920540794634, 7980.880286795703, 8011.078725946474, 8036.276735093869, 3109.7356724678657, 3145.213696575856, 3148.826814525223, 3168.477201261766, 3180.538821870816, 852.2542775071812, 856.4219152072326, 919.5310391700281, 955.3455882720359, 959.7216807125994, 27317.863410682818, 27912.86043569769, 28011.439771204463, 28111.0, 28726.569101463494, 913.8126684029891, 981.5582987655583, 1030.5002073994108, 1042.6871938418444, 1045.513836066233, 14228.0, 14905.403783848742, 15070.773938390932, 15237.695246095016, 15411.075335479907, 371757.0, 374077.0, 376240.0, 376732.0, 376819.0, 48919.26621100686, 49433.0, 49451.752741236065, 49658.50341496611, 49710.25434618483, 1059.941703206331, 1097.4786976186408, 1130.6438471881331, 1170.9004734597654, 1191.7378176801262, 25827.483450330514, 27985.440291193656, 28575.27780411275, 29828.850855745583, 29954.550681740227, 43507.78246108749, 48236.517634823205, 48261.0, 48310.27534586914, 48337.516624833304, 328907.0, 333974.0, 334176.0, 334918.0, 335310.1751859894, 31882.0, 32763.0, 35584.11039724028, 36470.452943205346, 38317.80841095777, 40691.18617627572, 41111.38332924949, 41280.1743965113, 41892.58107418887, 42227.0, 34443.31113377668, 34607.65392346044, 34906.47640285347, 34994.0, 35269.47095793514, 34255.65744342525, 34603.30793384169, 35309.646903530636, 35494.29011419809, 35503.0, 34658.48012279868, 35051.29897402089, 35298.11754706153, 35561.288774224886, 35841.0, 29967.400651987275, 31488.212794680316, 31976.68023319737, 32070.518942215418, 32225.838870805495, 24415.633765493178, 24900.875495622407, 24926.252212433657, 25377.0, 25386.238412847644], "value": 16595.652990246628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.84698809029993, 365.33873688623595, 370.54052974311855, 375.70882566011346, 384.0935392473763, 12436.502539898405, 13003.154794938335, 15928.203589820492, 16777.66444671106, 16919.06945118021, 16295.185240737976, 16854.0, 16861.83138168621, 16980.660386792286, 16985.3205871765, 4559.384483094789, 4986.5013498650205, 5030.647854650176, 5037.0, 5043.041822053798, 3636.181859081712, 3821.5796262411113, 4919.901601967958, 5016.824411145611, 5632.915506267409, 5951.315598706161, 5980.700964951735, 5981.102834574827, 5986.640801551921, 6000.699965001754, 5685.77256909721, 5830.154627578977, 5854.5023672987845, 5859.824205273806, 5955.3449120596915, 5110.28456016158, 5112.616553758483, 5115.846524604268, 5121.692698438105, 5122.743862806845, 20801.89599051995, 20973.68539471909, 21004.0, 21067.8946605266, 21134.0, 1926.3257859748976, 1939.4763413878316, 1948.2207117153112, 1981.782003979561, 1982.623301572711, 12449.0, 13248.801267980987, 13525.120867143603, 13832.515861944783, 13993.300334983312, 1656.7266401043814, 1663.3346661335443, 1683.2761912377673, 1727.041491971955, 1787.240422820296, 43210.351844722354, 46801.76599117017, 62712.68643656753, 62841.0, 65766.34233657698, 9419.199368053793, 9446.95276523613, 9862.0, 9888.406695598143, 10035.899641003643, 13465.596032119052, 13482.797758033637, 13503.12229705066, 13504.189748615114, 13512.729745405037, 7253.963730181421, 7284.125904891341, 7398.815029624195, 7594.96202518995, 7596.126445458733, 7220.9638951805955, 7232.566046037149, 7259.237780033126, 7430.851382972419, 7443.255674432622, 4069.4302797608357, 4104.712670113064, 4127.8968025799595, 4135.875923722233, 4258.787060646955, 1709.290644382592, 1831.3407173417559, 1864.7202919561903, 1870.990645046766, 1888.8772229805293, 670.6750745466062, 811.2293321344628, 822.9012518497699, 841.4488510025943, 845.6236974546268, 16244.918775406048, 16690.666186676197, 17437.302507899796, 17614.0, 17695.203715832817, 806.1535387842741, 836.3476488339105, 842.2714352085402, 856.9689835090875, 866.7703058689452, 9243.584038718274, 9520.523973801282, 9802.607895684236, 9817.0, 9982.450965196838, 383777.0, 389365.0, 396415.0, 396552.51712242817, 398568.0, 45904.540954590695, 46413.76793116013, 46749.29876051862, 48881.755591221816, 73449.2655073453, 900.1943260781695, 904.5160838951261, 929.3076657889916, 929.8605209218535, 930.7207837648814, 15108.622284442978, 15178.696426071638, 15468.613284667974, 15878.841211588198, 15975.20123993819, 35360.29279414449, 35407.29185416226, 36082.8195859019, 36301.818490907375, 36356.81821590875, 48626.0, 48769.0, 48870.0, 50002.49997499979, 51102.23346649878, 6527.5757075789925, 6731.596104233761, 6748.831279218059, 7652.885206721792, 7796.298333150044, 10927.781444371227, 11073.390963497084, 11715.238509496856, 12232.877671223174, 12614.495420183457, 10155.847662284923, 10374.896251037393, 10611.469426528796, 10632.627858024933, 10903.727406814893, 10001.0, 10007.699769006942, 10299.742506437398, 10302.175825934057, 10336.0, 5412.485813847678, 5785.971070144622, 9499.767554624796, 10223.0, 10670.89329106699, 7390.782765170535, 7472.701091956261, 7719.768406947801, 7746.845063098819, 7838.137804841349, 8577.82844343122, 10464.110550603284, 10581.629642962767, 10618.256722029384, 11071.391073491035], "value": 8025.846160951857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.2115570080102, 1375.2985977151652, 1427.4932398998355, 1653.2312474699263, 1681.1258145764211, 6252.6561039142825, 6709.563878347904, 6717.3618506241955, 6719.193696756384, 6734.52858299918, 5856.648601083938, 6070.453659170674, 6508.349165083489, 6698.631575263371, 6701.430378417828, 2071.7099606055126, 2087.3946555498887, 2095.4866057815857, 2098.3600001999384, 2098.9055492502875, 2056.516718571135, 2098.7166732491146, 2099.338708306886, 2121.5226574020876, 2128.0849234829016, 1795.1293622593032, 1841.2542920117373, 1923.3556758485925, 1960.2746983616082, 2067.1008111471483, 2002.1590931808603, 2014.979850201494, 2018.6971954206986, 2020.7170996060563, 2024.331970449748, 1969.4583989402886, 1973.250164937329, 1981.8018198180212, 2008.1465377214624, 2013.9697904531297, 6739.292374300677, 6869.0383346331555, 6871.03805467235, 6888.345607167311, 6902.965485172542, 4241.745495270263, 4366.345048242789, 4367.67242456817, 4371.322445021026, 4372.322290045048, 2703.9594406083925, 2780.7358300961578, 2806.9157925262275, 2819.6898341182455, 2874.1664917173994, 918.081918081918, 945.0785484152965, 953.4565297780268, 964.2334344196381, 974.6491263145263, 8980.191782739585, 9039.502827344493, 9046.592903319366, 9056.411333263317, 9061.139191776836, 3724.5530536335814, 3817.0648191193336, 3893.162969961472, 3905.4727611772614, 3980.402939559089, 7806.1413244543055, 7806.453548251681, 7809.297163255221, 7813.609319534001, 7825.082854700635, 4339.132173565299, 4342.0, 4345.9348109778375, 4349.173657005159, 4349.739015659071, 3858.228354329089, 3962.3660214365564, 3964.0288129408477, 3966.8214930328204, 3967.484227050523, 3274.8526316315824, 3283.3761585298716, 3335.7498187636024, 3370.0, 3384.0693809202176, 1158.9942050289694, 1173.5305877648839, 1183.7573297474169, 1189.7323102301914, 1192.9761404771857, 757.5189754505928, 783.804048987753, 787.2757063501592, 831.3681601982416, 840.7729912923477, 4658.906821863544, 4868.537488938545, 4910.926336104962, 4919.852404427873, 5113.616478764033, 419.67684882640805, 419.83626385709596, 421.4373810962338, 422.54576330444894, 423.13257821465874, 3283.113559338965, 3306.3056758080593, 3312.7349812015464, 3334.5164951082443, 3414.573178352706, 7843.098043725045, 8102.108768035511, 8223.342132629376, 8231.218034286852, 8254.752357429286, 8173.346132309401, 8174.632141553644, 8175.550344731097, 8180.345572354197, 8191.467554608931, 6325.0, 6418.871622567616, 6419.1334169887405, 6428.067930150102, 6442.35576442352, 4668.299755036635, 4685.625149988061, 4742.502037286035, 4783.6412269079265, 4808.134535783593, 7361.337479626859, 7407.0, 7582.772516824504, 7634.427417943787, 7669.808254793452, 7529.58587277705, 7588.430867685056, 7651.655675494505, 7711.1517733048195, 7720.382369410546, 5776.277965254343, 5800.564957628279, 5898.4101589840675, 5950.3454619992635, 6018.428249316308, 6668.166479190101, 6700.497462690415, 6704.262531121475, 6719.26088130315, 6719.630420326929, 5890.087036509348, 5926.762929482945, 5996.190514280516, 6033.215681961317, 6096.512279017757, 5898.0, 5900.675462849585, 5930.466258036798, 5937.011101281119, 5967.403259673998, 5792.913106303493, 5887.499562537232, 5893.233879595625, 5895.29256489224, 5899.410058994238, 4151.252774500619, 4163.084121493267, 4279.272523671046, 4287.292596721506, 4298.333758267474, 4144.772037537964, 4152.356384760367, 4204.810783514688, 4226.746395216297, 4348.173846969065], "value": 3701.8083749205944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2141478811089, 303.50074128059356, 304.41400304414003, 311.1660749192165, 315.0658298145998, 4553.612942899853, 4610.4467463904375, 4666.883327916804, 4697.735074123486, 4824.638152138595, 4678.251479763238, 4757.0, 4786.4974177711365, 4790.496997815223, 4808.951910480894, 3756.4365345198303, 3767.9434808477895, 3784.6972242220554, 3796.7721936683747, 3805.067758399196, 3626.4560315952685, 3784.9053773655605, 3790.810459477029, 3792.2984247914223, 3797.810109494528, 3637.4725664778593, 3699.149195684994, 3730.5709843367954, 3778.0, 3792.6396992285827, 3767.416050512175, 3779.640934111255, 3780.111673756665, 3787.280416720842, 3798.90502737431, 3323.4682450807754, 3357.227837597342, 3372.15696075981, 3375.240570871534, 3388.0, 4479.5296493868, 4627.431775364671, 4678.157931572316, 4679.60223381013, 4680.0, 4270.850520231808, 4278.358246263086, 4285.1429714057, 4288.9920868595855, 4290.034742183015, 4980.277859710358, 4987.850364489072, 4988.5260900214425, 5004.848884756527, 5013.924791128136, 3352.7988320700592, 3620.294042661682, 3634.3821550336506, 3641.3445579795625, 3643.890683279479, 5144.254083157921, 5188.403333616645, 5189.610779191538, 5212.661177023481, 5224.451432599561, 3626.202235508184, 3628.32875917956, 3638.1086633774366, 3648.1609229877276, 3651.342758303531, 3677.8161091945294, 3679.8344074516713, 3683.37382644951, 3702.129999450127, 3702.6675991607767, 4081.3265811140827, 4136.358864376027, 4189.141226048653, 4192.763134875219, 4196.895077623023, 4931.18635425158, 4937.925931111036, 4942.481039490802, 4955.628327875424, 4959.437777100202, 1244.7821631214501, 1265.569706299844, 1266.7593157300084, 1267.7147641780525, 1267.9429425675867, 740.7629558541323, 789.960501974899, 798.9241022102891, 799.4563696686193, 800.0159803441683, 3921.3333733265413, 3921.8823435296986, 3928.46965659638, 3939.3893946438347, 3955.259685738266, 4511.05267893746, 4523.88690282739, 4529.547045295444, 4530.097359109116, 4531.737149252533, 3923.5684074751753, 3937.2322397132284, 3943.3099207638547, 3955.307821131348, 3955.3473676843, 2334.8715820630027, 2398.6042303020154, 2427.939301517441, 2430.586800243963, 2435.2572465398225, 4245.724027938174, 4276.743395396286, 4280.315149576115, 4311.965128369169, 4316.460442444694, 4555.908881822345, 4567.858035491127, 4592.747398893026, 4606.401167848226, 4610.654200934876, 4089.3048181809163, 4269.658427325744, 4307.8492252771, 4316.525182229952, 4318.352247162888, 4485.596296333346, 4496.7077139985795, 4501.41481607389, 4504.729716217037, 4511.842085526991, 4447.266201076786, 4451.732896026248, 4457.710248833815, 4466.352378905106, 4796.0, 4763.333133361401, 4769.713817170981, 4868.440129385024, 4886.534039787978, 4891.144049791344, 3637.199816040467, 3638.363286424812, 3643.981780091083, 3649.4160934250394, 3656.5246517952496, 5010.36748357438, 5186.222066690027, 5187.688738675692, 5193.4027586828, 5195.558377537952, 4964.156093464047, 4976.651634385558, 5006.749662516932, 5009.298698182184, 5014.473480284518, 4976.138720235806, 4988.575971042502, 5000.024990128806, 5014.774335154853, 5024.42219144803, 4717.410323709536, 4934.55588996992, 4949.307097006494, 4955.727434990966, 4965.726885021359, 4998.2502624606595, 5036.169032109661, 5036.496350365081, 5042.697438153723, 5052.444231134646, 4924.433690125681, 4927.310176575211, 4940.135476291706, 4955.50444955516, 4963.875903102451], "value": 3654.9625140629655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.3145557259379, 682.7200847652464, 718.8885722712978, 732.5568031341038, 749.7038669725457, 12143.149979501439, 13318.800217996726, 13330.60008199753, 13333.7999930001, 13427.798583021262, 12491.812622810665, 12569.245845249268, 12570.30863302518, 12619.24284542928, 12663.430145643446, 617.3857012272795, 628.6228263042161, 779.0923574036241, 788.7318311773996, 789.4118881433341, 766.6741634805213, 777.996110019452, 792.4492477727981, 797.8922845415852, 798.1419973528451, 829.2163905109644, 829.7469271872106, 831.538496134645, 831.6673330667751, 832.7418500264937, 641.9518536109811, 655.4985436141355, 824.7938015496126, 825.7110011495959, 825.7233826668073, 485.82267472372683, 485.83967290794305, 486.51105638832746, 587.5769445998874, 597.2951916738247, 12211.450484728208, 12291.446884890202, 12292.75414491714, 12301.630951071482, 12317.384130793425, 11792.056635469142, 11947.522099116024, 12221.755564888741, 12329.075319351085, 12365.14522821575, 11058.723531911766, 11093.16801239902, 11341.546338146465, 11414.14393920451, 11814.586489472827, 4016.5380981187245, 4043.2924238258483, 4097.180563887205, 4141.295979683431, 4150.481189851269, 48129.75935120337, 48282.75758636198, 48288.517114829105, 48367.274490882664, 48367.274490882664, 8884.540898836109, 9013.143751343612, 9191.816163676824, 9301.441913485212, 9392.953035234917, 15821.920890395475, 15931.761023584655, 16029.839701602834, 16036.75944860828, 16051.277692503865, 6516.0, 6592.472602191813, 6727.317921948795, 6770.32296770319, 6807.897881531781, 3340.448825943692, 3433.9484907726405, 3461.8442170102408, 3474.756767026284, 3584.0143960411096, 2553.323369307135, 2653.840769553833, 2658.1361057655954, 2658.720834312408, 3033.6966303369927, 534.4628648208526, 536.3510152715259, 540.2571464236675, 540.8972295263966, 551.41274542612, 585.411661280419, 586.6978506069378, 635.8808497045234, 645.0646562484417, 651.9210706281112, 7969.920300797034, 8142.959285203655, 8187.959060204661, 8250.38122140842, 8252.876206856901, 600.9178197545526, 611.5476937480735, 617.6325086573481, 631.9684015799191, 648.1800522339245, 3927.410888366711, 4017.2568074906235, 4083.571225021389, 4098.7950602469755, 4131.958680413218, 40145.0, 50606.74696626493, 71022.64488677523, 75223.62388188024, 75395.62302188564, 41806.79096604497, 42218.78890605527, 62130.0, 64742.67628661827, 66324.6683766578, 58245.70877145587, 58415.70792146012, 58483.0, 58864.7056764722, 59797.70101149466, 7457.850842983218, 7586.810329741801, 7656.578888161204, 7710.8843367350655, 8023.318017968538, 38114.61885381111, 38543.42184867173, 38609.42085868658, 39090.609093909836, 39802.60197397989, 37492.43761343636, 54261.0, 54405.45594544004, 54908.725456372464, 57062.714686426305, 9609.298807794254, 9634.662786802428, 9817.165540929102, 9972.202223822222, 10174.593016279561, 11181.105511559219, 11181.888181118085, 11228.0, 11283.435828208392, 11286.379249141377, 10406.323588966692, 10528.684139475828, 10561.63034293796, 10566.418846963183, 10589.894101059199, 10537.736556586147, 10539.894601054199, 10583.5237414315, 10611.469426528796, 10905.56377744913, 9715.757106072404, 9801.11789938909, 9865.408075515492, 9911.10800027972, 10465.633702820365, 9804.754881128029, 9970.800583988135, 10055.497225138568, 10121.645742398981, 10230.846537302095, 10131.696049118538, 10224.897751022394, 10294.536745846304, 10360.533775979948, 10459.215558832966], "value": 6101.127853524307, "unit": "score"}], "name": "dromaeo_css", "value": 6086.2934545489, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 119.0, 119.0, 120.0, 120.0, 119.0, 121.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 128.0, 171.0, 128.0, 129.0, 129.0, 133.0, 169.0, 129.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 161.0, 162.0, 163.0, 162.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 87.0, 77.0, 103.0, 77.0, 76.0, 77.0, 76.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 120.0, 83.0, 85.0, 85.0, 106.0, 83.0, 83.0, 117.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 64.0, 64.0, 66.0, 66.0, 73.0, 64.0, 63.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0, 67.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 93.0, 84.0, 87.0, 83.0, 89.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 145.0, 141.0, 141.0, 154.0, 142.0, 139.0, 139.0, 181.0, 143.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 174.0, 173.0, 177.0, 175.0, 177.0, 174.0, 176.0, 177.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 67.0, 70.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1552.4000000000003, "alertThreshold": 2.0}]} 20:25:43 INFO - Return code: 0 20:25:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:25:43 INFO - # TBPL SUCCESS # 20:25:43 INFO - Running post-action listener: _resource_record_post_action 20:25:43 INFO - [mozharness: 2016-11-01 03:25:43.783184Z] Finished run-tests step (success) 20:25:43 INFO - Running post-run listener: _resource_record_post_run 20:25:43 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397676544; Read time: 12; Write time: 299728 20:25:43 INFO - TinderboxPrint: CPU usage
13.1% 20:25:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:25:43 INFO - TinderboxPrint: I/O write bytes / time
397,676,544 / 299,728 20:25:43 INFO - TinderboxPrint: CPU idle
8,352.5 (86.9%) 20:25:43 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 20:25:43 INFO - TinderboxPrint: Swap in / out
0 / 0 20:25:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106160128; Read time: 0; Write time: 85712 20:25:43 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290623488; Read time: 12; Write time: 213996 20:25:44 INFO - Running post-run listener: _upload_blobber_files 20:25:44 INFO - Blob upload gear active. 20:25:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:25:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:25:44 INFO - (blobuploader) - INFO - Open directory for files ... 20:25:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:25:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:46 INFO - (blobuploader) - INFO - Done attempting. 20:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:25:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:51 INFO - (blobuploader) - INFO - Done attempting. 20:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:52 INFO - (blobuploader) - INFO - Done attempting. 20:25:52 INFO - (blobuploader) - INFO - Iteration through files over. 20:25:52 INFO - Return code: 0 20:25:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:25:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:25:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84f3838b9936c2681860b20d4681473205a3b44a357527564b16c137b8768c2c6f1225fadb2a1725499408d6dd2dbc441ad376bd599968ae40123bc4d05ed0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9a3e6a8585d6101055754e807eb165845357e5d6bb1e422a55d5f8237e1042bfcc6045bbcb3ab8a4e7cf497b69be5a8a232f2aa1173638332f52c61150abb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0100bf77fff8c75b9319c2fc0c603788ab015553b1c5beff996395a23d9f21e29c8bc33efba70654e11134d8f2d4f53a1211396272624275a3dc3843ba5d42e9"} 20:25:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:25:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:25:52 INFO - Contents: 20:25:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84f3838b9936c2681860b20d4681473205a3b44a357527564b16c137b8768c2c6f1225fadb2a1725499408d6dd2dbc441ad376bd599968ae40123bc4d05ed0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9a3e6a8585d6101055754e807eb165845357e5d6bb1e422a55d5f8237e1042bfcc6045bbcb3ab8a4e7cf497b69be5a8a232f2aa1173638332f52c61150abb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0100bf77fff8c75b9319c2fc0c603788ab015553b1c5beff996395a23d9f21e29c8bc33efba70654e11134d8f2d4f53a1211396272624275a3dc3843ba5d42e9"} 20:25:52 INFO - Running post-run listener: copy_logs_to_upload_dir 20:25:52 INFO - Copying logs to upload dir... 20:25:52 INFO - mkdir: /builds/slave/test/build/upload/logs 20:25:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.749253 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-31 20:25:52.497227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 20:25:52.502987) ========= 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=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84f3838b9936c2681860b20d4681473205a3b44a357527564b16c137b8768c2c6f1225fadb2a1725499408d6dd2dbc441ad376bd599968ae40123bc4d05ed0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9a3e6a8585d6101055754e807eb165845357e5d6bb1e422a55d5f8237e1042bfcc6045bbcb3ab8a4e7cf497b69be5a8a232f2aa1173638332f52c61150abb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0100bf77fff8c75b9319c2fc0c603788ab015553b1c5beff996395a23d9f21e29c8bc33efba70654e11134d8f2d4f53a1211396272624275a3dc3843ba5d42e9"} build_url:https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/CjaTI6GLTju5pJ8Y6ZRHkA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f84f3838b9936c2681860b20d4681473205a3b44a357527564b16c137b8768c2c6f1225fadb2a1725499408d6dd2dbc441ad376bd599968ae40123bc4d05ed0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9a3e6a8585d6101055754e807eb165845357e5d6bb1e422a55d5f8237e1042bfcc6045bbcb3ab8a4e7cf497b69be5a8a232f2aa1173638332f52c61150abb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0100bf77fff8c75b9319c2fc0c603788ab015553b1c5beff996395a23d9f21e29c8bc33efba70654e11134d8f2d4f53a1211396272624275a3dc3843ba5d42e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 20:25:52.530307) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:25:52.530654) ========= 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=cbe409c6de289db6ac707de3000001d4-1477969500.59744-2556704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:25:52.612575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 20:25:52.613124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 20:25:52.613759) ========= ========= Total master_lag: 0.18 =========